builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1459526836.09 results: success (0) buildid: 20160401083710 builduid: 8212e5ee13214ff4905dc9207ba1efd6 revision: b73dfc2916f959611cc90ee906678a5bf11a0b5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.092651) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.093052) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.093352) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006434 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.119369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.119689) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.161190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.161457) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.222357) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.222640) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.223013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.223301) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 09:07:16-- 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% 12.4M=0.001s 2016-04-01 09:07:16 (12.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115520 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.351503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.351814) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020399 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:16.403318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 09:07:16.403666) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b73dfc2916f959611cc90ee906678a5bf11a0b5f --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 b73dfc2916f959611cc90ee906678a5bf11a0b5f --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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 09:07:16,600 truncating revision to first 12 chars 2016-04-01 09:07:16,600 Setting DEBUG logging. 2016-04-01 09:07:16,600 attempt 1/10 2016-04-01 09:07:16,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b73dfc2916f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 09:07:17,645 unpacking tar archive at: fx-team-b73dfc2916f9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.639119 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 09:07:18.056640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:18.056979) ========= echo b73dfc2916f959611cc90ee906678a5bf11a0b5f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b73dfc2916f959611cc90ee906678a5bf11a0b5f'] 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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b73dfc2916f959611cc90ee906678a5bf11a0b5f program finished with exit code 0 elapsedTime=0.003593 script_repo_revision: 'b73dfc2916f959611cc90ee906678a5bf11a0b5f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:18.106108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:18.106436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 09:07:18.116492) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-01 09:07:18.116806) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:18 INFO - MultiFileLogger online at 20160401 09:07:18 in /builds/slave/test 09:07:18 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 09:07:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:07:18 INFO - {'append_to_log': False, 09:07:18 INFO - 'base_work_dir': '/builds/slave/test', 09:07:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:07:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:07:18 INFO - 'branch': 'Fx-Team-Non-PGO', 09:07:18 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:18 INFO - 'config_files': ('talos/linux_config.py',), 09:07:18 INFO - 'default_actions': ('clobber', 09:07:18 INFO - 'read-buildbot-config', 09:07:18 INFO - 'download-and-extract', 09:07:18 INFO - 'populate-webroot', 09:07:18 INFO - 'create-virtualenv', 09:07:18 INFO - 'install', 09:07:18 INFO - 'run-tests'), 09:07:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:18 INFO - 'download_minidump_stackwalk': True, 09:07:18 INFO - 'download_symbols': 'ondemand', 09:07:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:18 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:18 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:18 INFO - 'installer_path': 'installer.exe', 09:07:18 INFO - 'log_level': 'info', 09:07:18 INFO - 'log_name': 'talos', 09:07:18 INFO - 'log_to_console': True, 09:07:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:18 INFO - 'opt_config_files': (), 09:07:18 INFO - 'pip_index': False, 09:07:18 INFO - 'sps_profile': False, 09:07:18 INFO - 'sps_profile_interval': 0, 09:07:18 INFO - 'suite': 'dromaeojs', 09:07:18 INFO - 'system_bits': '32', 09:07:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:18 INFO - 'title': 'talos-linux64-ix-022', 09:07:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:18 INFO - 'use_talos_json': True, 09:07:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:07:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:18 INFO - 'work_dir': 'build'} 09:07:18 INFO - ##### 09:07:18 INFO - ##### Running clobber step. 09:07:18 INFO - ##### 09:07:18 INFO - Running pre-action listener: _resource_record_pre_action 09:07:18 INFO - Running main action method: clobber 09:07:18 INFO - rmtree: /builds/slave/test/build 09:07:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:07:18 INFO - Running post-action listener: _resource_record_post_action 09:07:18 INFO - ##### 09:07:18 INFO - ##### Running read-buildbot-config step. 09:07:18 INFO - ##### 09:07:18 INFO - Running pre-action listener: _resource_record_pre_action 09:07:18 INFO - Running main action method: read_buildbot_config 09:07:18 INFO - Using buildbot properties: 09:07:18 INFO - { 09:07:18 INFO - "project": "", 09:07:18 INFO - "product": "firefox", 09:07:18 INFO - "script_repo_revision": "production", 09:07:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:07:18 INFO - "repository": "", 09:07:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:07:18 INFO - "buildid": "20160401083710", 09:07:18 INFO - "pgo_build": "False", 09:07:18 INFO - "basedir": "/builds/slave/test", 09:07:18 INFO - "buildnumber": 1590, 09:07:18 INFO - "slavename": "talos-linux64-ix-022", 09:07:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:07:18 INFO - "platform": "ubuntu64_hw", 09:07:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:07:18 INFO - "branch": "fx-team", 09:07:18 INFO - "repo_path": "integration/fx-team", 09:07:18 INFO - "revision": "b73dfc2916f959611cc90ee906678a5bf11a0b5f", 09:07:18 INFO - "stage_platform": "linux64", 09:07:18 INFO - "builduid": "8212e5ee13214ff4905dc9207ba1efd6", 09:07:18 INFO - "slavebuilddir": "test" 09:07:18 INFO - } 09:07:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:07:18 INFO - Running post-action listener: _resource_record_post_action 09:07:18 INFO - ##### 09:07:18 INFO - ##### Running download-and-extract step. 09:07:18 INFO - ##### 09:07:18 INFO - Running pre-action listener: _resource_record_pre_action 09:07:18 INFO - Running main action method: download_and_extract 09:07:18 INFO - mkdir: /builds/slave/test/build/tests 09:07: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')]} 09:07:18 INFO - https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:07:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:07:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:07:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:20 INFO - Downloaded 1361 bytes. 09:07:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:07:20 INFO - Using the following test package requirements: 09:07:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:07:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:07:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:20 INFO - u'jsshell-linux-x86_64.zip'], 09:07:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:07:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:07:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:07:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:07:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:07:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:07: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')]} 09:07:20 INFO - https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:22 INFO - Downloaded 22112056 bytes. 09:07:22 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'] 09:07:22 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 09:07:23 INFO - Return code: 0 09:07:23 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 09:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:23 INFO - https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:25 INFO - Downloaded 22112056 bytes. 09:07:25 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'] 09:07:25 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 09:07:26 INFO - Return code: 0 09:07:26 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')]} 09:07:26 INFO - https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:28 INFO - Downloaded 10847534 bytes. 09:07:28 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'] 09:07:28 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 09:07:29 INFO - Return code: 0 09:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:29 INFO - https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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 09:07:31 INFO - Downloaded 54224437 bytes. 09:07:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:07:31 INFO - mkdir: /builds/slave/test/properties 09:07:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:31 INFO - Contents: 09:07:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:07:32 INFO - Running post-action listener: _resource_record_post_action 09:07:32 INFO - Running post-action listener: set_extra_try_arguments 09:07:32 INFO - ##### 09:07:32 INFO - ##### Running populate-webroot step. 09:07:32 INFO - ##### 09:07:32 INFO - Running pre-action listener: _resource_record_pre_action 09:07:32 INFO - Running main action method: populate_webroot 09:07:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:32 INFO - '--tppagecycles', 09:07:32 INFO - '7'], 09:07:32 INFO - 'tests': ['tsvgm']}}, 09:07:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:07:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:07:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'tests': ['damp', 'tps']}, 09:07:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['damp', 'tps']}, 09:07:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:07:32 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['dromaeo_dom']}, 09:07:32 INFO - 'other': {'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore', 09:07:32 INFO - 'tabpaint']}, 09:07:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore', 09:07:32 INFO - 'tabpaint']}, 09:07:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore', 09:07:32 INFO - 'tabpaint']}, 09:07:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore', 09:07:32 INFO - 'tabpaint']}, 09:07:32 INFO - 'other_l64': {'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore', 09:07:32 INFO - 'tabpaint']}, 09:07:32 INFO - 'other_nol64': {'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore', 09:07:32 INFO - 'tabpaint']}, 09:07:32 INFO - 'svgr': {'tests': ['tsvgx', 09:07:32 INFO - 'tsvgr_opacity', 09:07:32 INFO - 'tart', 09:07:32 INFO - 'tscrollx', 09:07:32 INFO - 'cart']}, 09:07:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['tsvgx', 09:07:32 INFO - 'tsvgr_opacity', 09:07:32 INFO - 'tart', 09:07:32 INFO - 'tscrollx', 09:07:32 INFO - 'cart']}, 09:07:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'tests': ['tp5o']}, 09:07:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['tp5o']}, 09:07:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--xperf_path', 09:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:32 INFO - 'tests': ['tp5n']}, 09:07:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--e10s', 09:07:32 INFO - '--xperf_path', 09:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:32 INFO - 'tests': ['tp5n']}}, 09:07:32 INFO - 'talos.zip': {'path': '', 09:07:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:32 INFO - Running post-action listener: _resource_record_post_action 09:07:32 INFO - ##### 09:07:32 INFO - ##### Running create-virtualenv step. 09:07:32 INFO - ##### 09:07:32 INFO - Running pre-action listener: _resource_record_pre_action 09:07:32 INFO - Running main action method: create_virtualenv 09:07:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:32 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 09:07:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:32 INFO - Using real prefix '/usr' 09:07:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:34 INFO - Installing pip.................done. 09:07:34 INFO - Return code: 0 09:07:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:07:34 INFO - Using env: {'DISPLAY': ':0', 09:07:34 INFO - 'HOME': '/home/cltbld', 09:07:34 INFO - 'LANG': 'en_US.UTF-8', 09:07:34 INFO - 'LANGUAGE': 'en_US:en', 09:07:34 INFO - 'LOGNAME': 'cltbld', 09:07:34 INFO - 'MAIL': '/var/mail/cltbld', 09:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:34 INFO - 'MOZ_NO_REMOTE': '1', 09:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:34 INFO - 'NO_EM_RESTART': '1', 09:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:34 INFO - 'PWD': '/builds/slave/test', 09:07:34 INFO - 'SHELL': '/bin/bash', 09:07:34 INFO - 'SHLVL': '1', 09:07:34 INFO - 'TERM': 'linux', 09:07:34 INFO - 'TMOUT': '86400', 09:07:34 INFO - 'USER': 'cltbld', 09:07:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:34 INFO - '_': '/tools/buildbot/bin/python'} 09:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:35 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 09:07:35 INFO - Cleaning up... 09:07:35 INFO - Return code: 0 09:07:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:07:35 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')]} 09:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:35 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')]} 09:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:35 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 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:35 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 09:07:35 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 09:07:35 INFO - Using env: {'DISPLAY': ':0', 09:07:35 INFO - 'HOME': '/home/cltbld', 09:07:35 INFO - 'LANG': 'en_US.UTF-8', 09:07:35 INFO - 'LANGUAGE': 'en_US:en', 09:07:35 INFO - 'LOGNAME': 'cltbld', 09:07:35 INFO - 'MAIL': '/var/mail/cltbld', 09:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:35 INFO - 'MOZ_NO_REMOTE': '1', 09:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:35 INFO - 'NO_EM_RESTART': '1', 09:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:35 INFO - 'PWD': '/builds/slave/test', 09:07:35 INFO - 'SHELL': '/bin/bash', 09:07:35 INFO - 'SHLVL': '1', 09:07:35 INFO - 'TERM': 'linux', 09:07:35 INFO - 'TMOUT': '86400', 09:07:35 INFO - 'USER': 'cltbld', 09:07:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:35 INFO - '_': '/tools/buildbot/bin/python'} 09:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:35 INFO - Downloading/unpacking psutil>=0.7.1 09:07:35 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 09:07:35 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 09:07:35 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 09:07:35 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 09:07:35 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 09:07:35 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 09:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:38 INFO - Installing collected packages: psutil 09:07:38 INFO - Running setup.py install for psutil 09:07:38 INFO - building 'psutil._psutil_linux' extension 09:07:38 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 09:07:38 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 09:07:38 INFO - building 'psutil._psutil_posix' extension 09:07:38 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 09:07:38 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 09:07:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:38 INFO - Successfully installed psutil 09:07:38 INFO - Cleaning up... 09:07:38 INFO - Return code: 0 09:07:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:38 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 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:38 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 09:07:38 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 09:07:38 INFO - Using env: {'DISPLAY': ':0', 09:07:38 INFO - 'HOME': '/home/cltbld', 09:07:38 INFO - 'LANG': 'en_US.UTF-8', 09:07:38 INFO - 'LANGUAGE': 'en_US:en', 09:07:38 INFO - 'LOGNAME': 'cltbld', 09:07:38 INFO - 'MAIL': '/var/mail/cltbld', 09:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:38 INFO - 'MOZ_NO_REMOTE': '1', 09:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:38 INFO - 'NO_EM_RESTART': '1', 09:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:38 INFO - 'PWD': '/builds/slave/test', 09:07:38 INFO - 'SHELL': '/bin/bash', 09:07:38 INFO - 'SHLVL': '1', 09:07:38 INFO - 'TERM': 'linux', 09:07:38 INFO - 'TMOUT': '86400', 09:07:38 INFO - 'USER': 'cltbld', 09:07:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:38 INFO - '_': '/tools/buildbot/bin/python'} 09:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:07:38 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 09:07:38 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 09:07:38 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 09:07:38 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 09:07:38 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 09:07:38 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 09:07:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:07:41 INFO - Installing collected packages: mozsystemmonitor 09:07:41 INFO - Running setup.py install for mozsystemmonitor 09:07:41 INFO - Successfully installed mozsystemmonitor 09:07:41 INFO - Cleaning up... 09:07:41 INFO - Return code: 0 09:07:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:41 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')]} 09:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:41 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')]} 09:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:41 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 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:41 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 09:07:41 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 09:07:41 INFO - Using env: {'DISPLAY': ':0', 09:07:41 INFO - 'HOME': '/home/cltbld', 09:07:41 INFO - 'LANG': 'en_US.UTF-8', 09:07:41 INFO - 'LANGUAGE': 'en_US:en', 09:07:41 INFO - 'LOGNAME': 'cltbld', 09:07:41 INFO - 'MAIL': '/var/mail/cltbld', 09:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:41 INFO - 'MOZ_NO_REMOTE': '1', 09:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:41 INFO - 'NO_EM_RESTART': '1', 09:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:41 INFO - 'PWD': '/builds/slave/test', 09:07:41 INFO - 'SHELL': '/bin/bash', 09:07:41 INFO - 'SHLVL': '1', 09:07:41 INFO - 'TERM': 'linux', 09:07:41 INFO - 'TMOUT': '86400', 09:07:41 INFO - 'USER': 'cltbld', 09:07:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:41 INFO - '_': '/tools/buildbot/bin/python'} 09:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:41 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:41 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 09:07:41 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 09:07:41 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 09:07:41 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 09:07:41 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 09:07:41 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 09:07:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:44 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 09:07:44 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 09:07:44 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 09:07:44 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 09:07:44 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 09:07:44 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 09:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:45 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 09:07:45 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 09:07:45 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 09:07:45 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 09:07:45 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 09:07:45 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 09:07:45 INFO - Downloading docopt-0.6.1.tar.gz 09:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:45 INFO - Running setup.py install for blobuploader 09:07:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:45 INFO - Running setup.py install for requests 09:07:45 INFO - Running setup.py install for docopt 09:07:45 INFO - Successfully installed blobuploader requests docopt 09:07:45 INFO - Cleaning up... 09:07:45 INFO - Return code: 0 09:07:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:45 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 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:45 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 09:07:45 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 09:07:45 INFO - Using env: {'DISPLAY': ':0', 09:07:45 INFO - 'HOME': '/home/cltbld', 09:07:45 INFO - 'LANG': 'en_US.UTF-8', 09:07:45 INFO - 'LANGUAGE': 'en_US:en', 09:07:45 INFO - 'LOGNAME': 'cltbld', 09:07:45 INFO - 'MAIL': '/var/mail/cltbld', 09:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:45 INFO - 'MOZ_NO_REMOTE': '1', 09:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:45 INFO - 'NO_EM_RESTART': '1', 09:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:45 INFO - 'PWD': '/builds/slave/test', 09:07:45 INFO - 'SHELL': '/bin/bash', 09:07:45 INFO - 'SHLVL': '1', 09:07:45 INFO - 'TERM': 'linux', 09:07:45 INFO - 'TMOUT': '86400', 09:07:45 INFO - 'USER': 'cltbld', 09:07:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:45 INFO - '_': '/tools/buildbot/bin/python'} 09:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:46 INFO - Running setup.py (path:/tmp/pip-zhcJPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:46 INFO - Running setup.py (path:/tmp/pip-2MKJnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:46 INFO - Running setup.py (path:/tmp/pip-m3eb3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:46 INFO - Running setup.py (path:/tmp/pip-_FYUq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:46 INFO - Running setup.py (path:/tmp/pip-r2xPrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:46 INFO - Running setup.py (path:/tmp/pip-laqp3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:46 INFO - Running setup.py (path:/tmp/pip-su4jb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:46 INFO - Running setup.py (path:/tmp/pip-ghUaJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:46 INFO - Running setup.py (path:/tmp/pip-J67RBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:46 INFO - Running setup.py (path:/tmp/pip-vOXwIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:46 INFO - Running setup.py (path:/tmp/pip-53EObU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:46 INFO - Running setup.py (path:/tmp/pip-wj8qus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:46 INFO - Running setup.py (path:/tmp/pip-1uhFNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:47 INFO - Running setup.py (path:/tmp/pip-Wx3rWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:47 INFO - Running setup.py (path:/tmp/pip-IDl12b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:47 INFO - Running setup.py (path:/tmp/pip-7aBNWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:47 INFO - Running setup.py (path:/tmp/pip-5wSilL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:47 INFO - Running setup.py install for manifestparser 09:07:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:47 INFO - Running setup.py install for mozcrash 09:07:47 INFO - Running setup.py install for mozdebug 09:07:47 INFO - Running setup.py install for mozdevice 09:07:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:07:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:47 INFO - Running setup.py install for mozfile 09:07:47 INFO - Running setup.py install for mozhttpd 09:07:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:47 INFO - Running setup.py install for mozinfo 09:07:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Running setup.py install for mozInstall 09:07:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Running setup.py install for mozleak 09:07:48 INFO - Running setup.py install for mozlog 09:07:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Running setup.py install for moznetwork 09:07:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Running setup.py install for mozprocess 09:07:48 INFO - Running setup.py install for mozprofile 09:07:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Running setup.py install for mozrunner 09:07:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Running setup.py install for mozscreenshot 09:07:48 INFO - Running setup.py install for moztest 09:07:48 INFO - Running setup.py install for mozversion 09:07:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:49 INFO - Cleaning up... 09:07:49 INFO - Return code: 0 09:07:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:49 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 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:49 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 09:07:49 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 09:07:49 INFO - Using env: {'DISPLAY': ':0', 09:07:49 INFO - 'HOME': '/home/cltbld', 09:07:49 INFO - 'LANG': 'en_US.UTF-8', 09:07:49 INFO - 'LANGUAGE': 'en_US:en', 09:07:49 INFO - 'LOGNAME': 'cltbld', 09:07:49 INFO - 'MAIL': '/var/mail/cltbld', 09:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:49 INFO - 'MOZ_NO_REMOTE': '1', 09:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:49 INFO - 'NO_EM_RESTART': '1', 09:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:49 INFO - 'PWD': '/builds/slave/test', 09:07:49 INFO - 'SHELL': '/bin/bash', 09:07:49 INFO - 'SHLVL': '1', 09:07:49 INFO - 'TERM': 'linux', 09:07:49 INFO - 'TMOUT': '86400', 09:07:49 INFO - 'USER': 'cltbld', 09:07:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:49 INFO - '_': '/tools/buildbot/bin/python'} 09:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:49 INFO - Running setup.py (path:/tmp/pip-qJJ2h1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:49 INFO - Running setup.py (path:/tmp/pip-jNby5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:49 INFO - Running setup.py (path:/tmp/pip-S8t_QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:49 INFO - Running setup.py (path:/tmp/pip-hfZvSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:49 INFO - Running setup.py (path:/tmp/pip-gGaezH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:49 INFO - Running setup.py (path:/tmp/pip-mHwPA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:49 INFO - Running setup.py (path:/tmp/pip-y0Q_Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:49 INFO - Running setup.py (path:/tmp/pip-tTblva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:49 INFO - Running setup.py (path:/tmp/pip-QitlUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:49 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)) 09:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:49 INFO - Running setup.py (path:/tmp/pip-OboM_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:50 INFO - Running setup.py (path:/tmp/pip-xMudzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:50 INFO - Running setup.py (path:/tmp/pip-6gw8ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:50 INFO - Running setup.py (path:/tmp/pip-CuTy1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:50 INFO - Running setup.py (path:/tmp/pip-ZTVfLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:50 INFO - Running setup.py (path:/tmp/pip-DPmSr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:50 INFO - Running setup.py (path:/tmp/pip-1XexE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:50 INFO - Running setup.py (path:/tmp/pip-15mlSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:50 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)) 09:07:50 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)) 09:07:50 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)) 09:07:50 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)) 09:07:50 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)) 09:07:50 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)) 09:07:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07:50 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 09:07:50 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 09:07:50 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 09:07:50 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 09:07:50 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 09:07:50 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 09:07:52 INFO - Downloading blessings-1.6.tar.gz 09:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:52 INFO - Installing collected packages: blessings 09:07:52 INFO - Running setup.py install for blessings 09:07:52 INFO - Successfully installed blessings 09:07:52 INFO - Cleaning up... 09:07:52 INFO - Return code: 0 09:07:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:53 INFO - Reading from file tmpfile_stdout 09:07:53 INFO - Current package versions: 09:07:53 INFO - argparse == 1.2.1 09:07:53 INFO - blessings == 1.6 09:07:53 INFO - blobuploader == 1.2.4 09:07:53 INFO - docopt == 0.6.1 09:07:53 INFO - manifestparser == 1.1 09:07:53 INFO - mozInstall == 1.12 09:07:53 INFO - mozcrash == 0.17 09:07:53 INFO - mozdebug == 0.1 09:07:53 INFO - mozdevice == 0.48 09:07:53 INFO - mozfile == 1.2 09:07:53 INFO - mozhttpd == 0.7 09:07:53 INFO - mozinfo == 0.9 09:07:53 INFO - mozleak == 0.1 09:07:53 INFO - mozlog == 3.1 09:07:53 INFO - moznetwork == 0.27 09:07:53 INFO - mozprocess == 0.22 09:07:53 INFO - mozprofile == 0.28 09:07:53 INFO - mozrunner == 6.11 09:07:53 INFO - mozscreenshot == 0.1 09:07:53 INFO - mozsystemmonitor == 0.0 09:07:53 INFO - moztest == 0.7 09:07:53 INFO - mozversion == 1.4 09:07:53 INFO - psutil == 3.1.1 09:07:53 INFO - requests == 1.2.3 09:07:53 INFO - wsgiref == 0.1.2 09:07:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:53 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 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:53 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 09:07:53 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 09:07:53 INFO - Using env: {'DISPLAY': ':0', 09:07:53 INFO - 'HOME': '/home/cltbld', 09:07:53 INFO - 'LANG': 'en_US.UTF-8', 09:07:53 INFO - 'LANGUAGE': 'en_US:en', 09:07:53 INFO - 'LOGNAME': 'cltbld', 09:07:53 INFO - 'MAIL': '/var/mail/cltbld', 09:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:53 INFO - 'MOZ_NO_REMOTE': '1', 09:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:53 INFO - 'NO_EM_RESTART': '1', 09:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:53 INFO - 'PWD': '/builds/slave/test', 09:07:53 INFO - 'SHELL': '/bin/bash', 09:07:53 INFO - 'SHLVL': '1', 09:07:53 INFO - 'TERM': 'linux', 09:07:53 INFO - 'TMOUT': '86400', 09:07:53 INFO - 'USER': 'cltbld', 09:07:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:53 INFO - '_': '/tools/buildbot/bin/python'} 09:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 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)) 09:07:53 INFO - Cleaning up... 09:07:53 INFO - Return code: 0 09:07:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:53 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 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:53 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 09:07:53 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 09:07:53 INFO - Using env: {'DISPLAY': ':0', 09:07:53 INFO - 'HOME': '/home/cltbld', 09:07:53 INFO - 'LANG': 'en_US.UTF-8', 09:07:53 INFO - 'LANGUAGE': 'en_US:en', 09:07:53 INFO - 'LOGNAME': 'cltbld', 09:07:53 INFO - 'MAIL': '/var/mail/cltbld', 09:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:53 INFO - 'MOZ_NO_REMOTE': '1', 09:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:53 INFO - 'NO_EM_RESTART': '1', 09:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:53 INFO - 'PWD': '/builds/slave/test', 09:07:53 INFO - 'SHELL': '/bin/bash', 09:07:53 INFO - 'SHLVL': '1', 09:07:53 INFO - 'TERM': 'linux', 09:07:53 INFO - 'TMOUT': '86400', 09:07:53 INFO - 'USER': 'cltbld', 09:07:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:53 INFO - '_': '/tools/buildbot/bin/python'} 09:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:53 INFO - Downloading/unpacking jsonschema 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:55 INFO - Downloading/unpacking functools32 (from jsonschema) 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:55 INFO - warning: no files found matching '*.txt' 09:07:55 INFO - no previously-included directories found matching 'build' 09:07:55 INFO - no previously-included directories found matching 'dist' 09:07:55 INFO - no previously-included directories found matching '.git*' 09:07:55 INFO - Installing collected packages: jsonschema, functools32 09:07:55 INFO - Running setup.py install for functools32 09:07:55 INFO - warning: no files found matching '*.txt' 09:07:55 INFO - no previously-included directories found matching 'build' 09:07:55 INFO - no previously-included directories found matching 'dist' 09:07:55 INFO - no previously-included directories found matching '.git*' 09:07:56 INFO - Successfully installed jsonschema functools32 09:07:56 INFO - Cleaning up... 09:07:56 INFO - Return code: 0 09:07:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:56 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 0x7f67f4591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', '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 09:07:56 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 09:07:56 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 09:07:56 INFO - Using env: {'DISPLAY': ':0', 09:07:56 INFO - 'HOME': '/home/cltbld', 09:07:56 INFO - 'LANG': 'en_US.UTF-8', 09:07:56 INFO - 'LANGUAGE': 'en_US:en', 09:07:56 INFO - 'LOGNAME': 'cltbld', 09:07:56 INFO - 'MAIL': '/var/mail/cltbld', 09:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:56 INFO - 'MOZ_NO_REMOTE': '1', 09:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:56 INFO - 'NO_EM_RESTART': '1', 09:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:56 INFO - 'PWD': '/builds/slave/test', 09:07:56 INFO - 'SHELL': '/bin/bash', 09:07:56 INFO - 'SHLVL': '1', 09:07:56 INFO - 'TERM': 'linux', 09:07:56 INFO - 'TMOUT': '86400', 09:07:56 INFO - 'USER': 'cltbld', 09:07:56 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:56 INFO - '_': '/tools/buildbot/bin/python'} 09:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:56 INFO - Downloading/unpacking flake8 09:07:56 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 09:07:56 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 09:07:56 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 09:07:56 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 09:07:56 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 09:07:56 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 09:07:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:07:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:07:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:07:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:07:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:07:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:07:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:07:59 INFO - no previously-included directories found matching 'docs/_build' 09:07:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:07:59 INFO - Running setup.py install for pep8 09:07:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:07:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:07:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:07:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:07:59 INFO - no previously-included directories found matching 'docs/_build' 09:07:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:07:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:07:59 INFO - Cleaning up... 09:07:59 INFO - Return code: 0 09:07:59 INFO - Running post-action listener: _resource_record_post_action 09:07:59 INFO - Running post-action listener: _start_resource_monitoring 09:07:59 INFO - Starting resource monitoring. 09:07:59 INFO - ##### 09:07:59 INFO - ##### Running install step. 09:07:59 INFO - ##### 09:07:59 INFO - Running pre-action listener: _resource_record_pre_action 09:07:59 INFO - Running main action method: install 09:07:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:59 INFO - Reading from file tmpfile_stdout 09:07:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:59 INFO - Reading from file tmpfile_stdout 09:07:59 INFO - Output received: 09:07:59 INFO - Usage: mozinstall [options] installer 09:07:59 INFO - Options: 09:07:59 INFO - -h, --help show this help message and exit 09:07:59 INFO - -d DEST, --destination=DEST 09:07:59 INFO - Directory to install application into. [default: 09:07:59 INFO - "/builds/slave/test"] 09:07:59 INFO - --app=APP Application being installed. [default: firefox] 09:07:59 INFO - mkdir: /builds/slave/test/build/application 09:07:59 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'] 09:07:59 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 09:08:15 INFO - Reading from file tmpfile_stdout 09:08:15 INFO - Output received: 09:08:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:08:15 INFO - Running post-action listener: _resource_record_post_action 09:08:15 INFO - ##### 09:08:15 INFO - ##### Running run-tests step. 09:08:15 INFO - ##### 09:08:15 INFO - Running pre-action listener: _resource_record_pre_action 09:08:15 INFO - Running main action method: run_tests 09:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:15 INFO - Python 2.7.3 09:08:15 INFO - Return code: 0 09:08:15 INFO - grabbing minidump binary from tooltool 09:08:15 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')]} 09:08:15 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 0x14f0410>, '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 0x14f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:15 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 09:08:15 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 09:08:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:15 INFO - Return code: 0 09:08:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:08:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:08:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:08:16 INFO - Return code: 0 09:08:16 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/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 09:08:16 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/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 09:08:16 INFO - Using env: {'DISPLAY': ':0', 09:08:16 INFO - 'HOME': '/home/cltbld', 09:08:16 INFO - 'LANG': 'en_US.UTF-8', 09:08:16 INFO - 'LANGUAGE': 'en_US:en', 09:08:16 INFO - 'LOGNAME': 'cltbld', 09:08:16 INFO - 'MAIL': '/var/mail/cltbld', 09:08:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:16 INFO - 'MOZ_NO_REMOTE': '1', 09:08:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:16 INFO - 'NO_EM_RESTART': '1', 09:08:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:16 INFO - 'PWD': '/builds/slave/test', 09:08:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:16 INFO - 'SHELL': '/bin/bash', 09:08:16 INFO - 'SHLVL': '1', 09:08:16 INFO - 'TERM': 'linux', 09:08:16 INFO - 'TMOUT': '86400', 09:08:16 INFO - 'USER': 'cltbld', 09:08:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616', 09:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:16 INFO - '_': '/tools/buildbot/bin/python'} 09:08:16 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/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 09:08:16 INFO - mozversion application_buildid: 20160401083710 09:08:16 INFO - mozversion application_changeset: b73dfc2916f959611cc90ee906678a5bf11a0b5f 09:08:16 INFO - mozversion application_display_name: Nightly 09:08:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:16 INFO - mozversion application_name: Firefox 09:08:16 INFO - mozversion application_remotingname: firefox 09:08:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:08:16 INFO - mozversion application_vendor: Mozilla 09:08:16 INFO - mozversion application_version: 48.0a1 09:08:16 INFO - mozversion platform_buildid: 20160401083710 09:08:16 INFO - mozversion platform_changeset: b73dfc2916f959611cc90ee906678a5bf11a0b5f 09:08:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:08:16 INFO - mozversion platform_version: 48.0a1 09:08:16 INFO - using testdate: 1459526896 09:08:16 INFO - actual date: 1459526896 09:08:16 INFO - starting webserver on 'localhost:39476' 09:08:16 INFO - SUITE-START | Running 2 tests 09:08:16 INFO - TEST-START | dromaeo_css 09:08:16 INFO - operating with platform_type : linux_ 09:08:16 INFO - Initialising browser for dromaeo_css test... 09:08:16 INFO - TEST-INFO | started process 26563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ3oyiH/profile http://localhost:39476/getInfo.html) 09:08:21 INFO - PROCESS | 26563 | __metrics Screen width/height:1600/1200 09:08:21 INFO - PROCESS | 26563 | colorDepth:24 09:08:21 INFO - PROCESS | 26563 | Browser inner width/height: 1024/697 09:08:21 INFO - PROCESS | 26563 | __metrics 09:08:22 ERROR - PROCESS | 26563 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:08:23 INFO - TEST-INFO | 26563: exit 0 09:08:23 INFO - Browser initialized. 09:08:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:23 INFO - TEST-INFO | started process 26643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ3oyiH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:35 INFO - PROCESS | 26643 | RSS: Main: 154873856 09:08:35 INFO - PROCESS | 26643 | 09:09:25 INFO - PROCESS | 26643 | 1459526965804 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] 09:11:38 INFO - PROCESS | 26643 | Cycle 1(1): loaded http://localhost:39476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39476/tests/dromaeo/cssquery-ext.html) 09:11:39 INFO - PROCESS | 26643 | RSS: Main: 228040704 09:11:39 INFO - PROCESS | 26643 | 09:14:41 INFO - PROCESS | 26643 | Cycle 1(1): loaded http://localhost:39476/tests/dromaeo/cssquery-ext.html (next: http://localhost:39476/tests/dromaeo/cssquery-jquery.html) 09:14:42 INFO - PROCESS | 26643 | RSS: Main: 236339200 09:14:42 INFO - PROCESS | 26643 | 09:17:44 INFO - PROCESS | 26643 | Cycle 1(1): loaded http://localhost:39476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39476/tests/dromaeo/cssquery-mootools.html) 09:17:44 INFO - PROCESS | 26643 | RSS: Main: 236269568 09:17:44 INFO - PROCESS | 26643 | 09:20:46 INFO - PROCESS | 26643 | Cycle 1(1): loaded http://localhost:39476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39476/tests/dromaeo/cssquery-prototype.html) 09:20:47 INFO - PROCESS | 26643 | RSS: Main: 210694144 09:20:47 INFO - PROCESS | 26643 | 09:23:50 INFO - PROCESS | 26643 | Cycle 1(1): loaded http://localhost:39476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39476/tests/dromaeo/cssquery-yui.html) 09:23:50 INFO - PROCESS | 26643 | RSS: Main: 197324800 09:23:50 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | Cycle 1(1): loaded http://localhost:39476/tests/dromaeo/cssquery-yui.html (next: http://localhost:39476/tests/dromaeo/cssquery-dojo.html) 09:26:53 INFO - PROCESS | 26643 | RSS: Main: 269983744 09:26:53 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | __start_tp_report 09:26:53 INFO - PROCESS | 26643 | _x_x_mozilla_page_load 09:26:53 INFO - PROCESS | 26643 | _x_x_mozilla_page_load_details 09:26:53 INFO - PROCESS | 26643 | |i|pagename|runs| 09:26:53 INFO - PROCESS | 26643 | |0;dojo.html;2655.1901669990652;2737.3704048068944;2750.40866213764;2755.517784387732;2778.124890659442;4550.544945505448;4633.5598118178805;4718.363020992165;4722.8583142505695;4730.290456431533;4665.9066818663605;4690.296455531672;4691.976540117304;4772.522747725226;4778.283257511375;4251.043515209069;4266.530681625019;4284.721493102938;4301.956980430187;4465.754383508905;4405.757683327432;4421.57994990477;4428.601425871687;4476.440444944382;4486.8878278042985;4219.135077309144;4302.397664326997;4311.805968731414;4378.474583050054;4378.8029538670835;4331.45856767904;4336.739795612273;4381.75900325482;4382.342648602735;4392.670549708785;4321.82712691492;4325.243082460557;4331.9783401083105;4345.391645169679;4365.607095361401;4458.576435238647;4533.410656614652;4544.454665440136;4615.307703844416;4626.236670949289;4979.950200497985;4982.327385802942;4988.725620090893;4989.027139707759;5008.54923056923;5005.3242812220615;5011.298418221452;5017.67385119966;5021.246812978046;5061.468545802674;4557.749323787223;4681.882952926136;4692.155412025868;4775.952240477551;4777.044591081728;5161.225816127611;5166;5179.352580927384;5179.81870634526;5198;4945.678530895552;4950.777215025332;4951.207806750975;4954.083494553519;4995.300657907896;4947.802087916443;4949.554540091409;4999.875003124878;5044.192929131322;5056.924146137811;4958.776855041532;4993.051320249141;5002.2496625506465;5004.349434573555;5048.899022019539;4799.280107983761;4996.550310472002;5003.449620541737;5006.274090256892;5057.367829021372;4212.30496968003;4257.1698518788535;4262.893427664271;4301.827926882952;4307.203167414038;3726.6087060858217;3733.8506459741307;3737.775733455947;3738.158914244273;3776.2825063238447;4215.852445164466;4308.784560771949;4329.307310830252;4330.004099057234;4357.041450880801;5014.924776128361;5058.620603454756;5070.974645126751;5101.923471147936;5106.46382129871;4312.762798046075;4331.6534677225745;4333.328334108218;4335.479742430865;4358.0412309291905;4445.310976798602;4476.597106260452;4564.178447879413;4572.657050721209;4603.079384123189;4773.880652983565;4789.4971028041555;4797.664163508521;4800.495947925488;4853.757312134449;5066.873328166826;5066.923996139987;5073.365829271341;5084.339035925306;5113.667611605234;4629.513901040477;4629.976850115728;4698.906021879611;4743.383360163295;4848.612111031039;4963.602911767122;4984.925226121683;4985.601151907911;5002.949970500248;5023.748812559431;5033.798648054037;5048.495150484922;5051;5053.67151135175;5074.314967479343;4805.951940480691;4824.95175048245;4886.92669609949;4892.730899800546;4960.355153829979;4819.373481447389;4828.49420002196;4850.272459131159;4868.41579010521;4888;4763.333133361401;4764.356811830358;4773.856784296477;4784.4497882742535;4825.782839772149;4804.231322988445;4875.43932447773;4892.217245240744;4960.950390496193;4987.900241995212;4792.281157826214;4794.328793968777;4806.8798280043275;4815.22956327;4857.441394239708 09:26:53 INFO - PROCESS | 26643 | |1;ext.html;538.8922215556888;540.9513143817055;544.2815483561698;555.9659034196394;566.6628356128105;26683.199504014887;33725.32549349015;34340.48489272663;34369.31261374771;34438;37130.443043354375;37569.62430375695;37586.624133758654;37634.43548346777;37661.05847353818;7565.054368203974;7725.652345644431;7735.690572377126;7738;7741.032370953631;7641.3122818946285;7753.185915478878;7760.340371068438;7778.49439786412;7960.920390796105;7880.5271683698875;7965.60171991401;7975.40184486163;7976.202379762035;7977.082635496934;7883.921160788404;7961.36309095271;7966.44234903557;7974.960125199366;7978.242067003625;7778.844423111563;7893.210678932118;7905.051393832719;7908.762737117896;7909.327707144899;37571.248575028345;37908.24183516342;38087.80956095229;38140.23719525622;38140.42789358162;3216.292415668549;3287.621923478807;3557.1996300832366;3645.7447978641508;3724.3296206682785;28447;29339;29367.853160734274;29373.70626293731;29432.264193395124;3441.690247877703;3470.8785192518394;3554.875579354736;3571;3579;238978;239266;240047;240362.7981860097;240366;46611.30083048757;53173.202401964;53604;53605.1959220612;55313.44686553083;48627.27059094117;48842.26736598954;48901.75549122231;48912.51087489151;48978.51021489811;12981.805272920914;13117.212967221998;13146.868531314565;13221.537246196336;13235.470581176838;9714.951425242829;9733.902660973441;9795.265355098396;9822.852657210147;9837.262205334628;16096.436624718313;16502;18283.63432731338;18536;18697.906510467634;6656.5340426169705;6852.862942741217;7038.260982596754;7055.788326350115;7250.6374681265725;817.5340056167927;883.7613844262013;940.3182692547985;940.3793496292415;941.3222479814523;23055.53888922212;23263.41841453977;23371.88314058419;23434.76565234326;23483.647745283834;948.8197242523898;961.6345788600287;966.4201479112617;976.7069879036261;984.1487113646788;12964.351782410842;13145.21128732279;13388.732225355438;13391.196528208338;13430.26133562644;276211;280917;281590;282071;282684;47310.29034564484;47618.761906190244;47662.76168619135;47692.7615361921;47698.52301476941;1051.30613794895;1186.7804456175636;1230.1573422205638;1240.2434514945876;1240.3116270469975;24255.393615159763;24606.876965615058;24625;24722.302762475072;24977.50044999126;37439.06402339855;37616.81191594025;37831.43252851154;37867;37877.242455151296;173687;174204;174568.12715936848;174780;174907.12546437187;26418.867905660347;30339.241518962204;31052.0684379469;31082.378352432374;31189.220269493446;36363.27273454569;38262.42606360851;38394.23211535809;38409.4238586427;38728.6127138725;35832.641673583974;36647;37083.629163708014;37207.81396093002;37370.626293736714;31332;31350.529742054343;31686.207844804063;31700.36599268048;31712;32208.838955806008;32276.410638826746;32898.67101329052;32912;32939.50590741093;28827.279318017216;28849.278768030967;28969.378827646546;28976.13071607855;29165.7083429163;23276.185333513247;23304.417389564718;23519.88240058789;23549.154242193566;23683.1710890118 09:26:53 INFO - PROCESS | 26643 | |2;jquery.html;338.8102662508994;339.6874875114894;346.98091604961735;354.44529311627304;361.88419705694173;15149.999999999985;15547.766783498242;16269.186540672963;16864.494065178034;16884.915575422106;15939.203039847991;16102.114383708891;17082.914585427054;17098.82901170988;17118.914405427957;4993.475685053071;5084.567811736007;5127.871803204931;5129.461406552315;5145.228215767646;4951.529604687549;5119.897602047957;5139.997700448414;5155.71643559604;5163.974180129113;5093.057784309896;5100.5154510321645;5103.311053007852;5105.974470127644;5116.2069879168785;5008.198688209887;5201.193814958669;5202.583793296527;5208.062548741225;5216.8174113906025;4996.12567800637;5018.949810501921;5026.321446604698;5027.095122877917;5027.27104569839;15132.5460236192;19012.61974760497;19974.70037949432;19995.300164494318;20001.499962500908;1912.6270377276437;1930.7774650120955;1939.8254157125784;2027.7161197432372;2470.110760126353;9320.300977426652;9440;9581.281403894665;10360.79278414435;12104.878951210463;1749.4401791426749;1778.5998150416183;1785.2680401035643;1793.8385545300855;1808.6021075363399;56450.717746411414;59239.70380148115;60005.6999715003;60224;60920;9380.812383752424;9501.857472137923;9607.375520591138;9747.61009559624;10178.81155551545;13117.934410327887;13239.470421183045;13257.204567725967;13262.867371326356;13280.203187808762;6388.744450221939;6451.935480645134;6707.865842683119;6804.693788779517;6817.454603631698;6119.571629985947;6163.445289923839;6219.968900155471;6223.719932603044;6256.749730010749;4174.227767862955;4188.434561334181;4227.513835908849;4277.1873344064525;4331.090471001062;1743.3264066496306;1786.4015554789032;1800.3428748506701;1801.261482792049;1819.5087326422056;894.3024440936081;926.9814603707888;955.8566215067657;970.9563069661882;973.8247115519274;15613.531594052196;15756.369745210062;15902.878355733736;16163.676726465404;16178.352865885468;831.7380025292014;845.3152946113545;857.3312816003527;895.8163576466809;927.1007123090591;9180;9217.539123043822;9229;9361.765955851159;9399.765005874771;376101;383757.16242837213;384841;392100;393783;47538.52461475341;60992;62824;68548.6811413963;70200.2979970204;887.4586502233632;913.456493386434;917.9862302065475;927.0266220468482;931.9161275485238;13840.792388114387;14018;14184;14252.572422827332;14405.7839132411;28564.57153142663;29734.25664358408;30333.848330758206;30996.69003309938;31594.684053160094;41497.37753933633;42613.786931065144;42991.57008429876;44589;44690.329645056;7323;7404.222556631476;7432.665530051053;7439;7467.589282589292;10465.319754215952;11388.088952883914;11693.941530292634;11786.41067946582;12167.391630418266;10209.438480883326;10397.948010260203;10402.167826574007;10504.422256775644;10530.31552949056;9779.364341317792;10316.381017138996;10446.52990615409;10450.738731531772;10555.841662374916;10461.68614941553;10473.31923424975;10605.787884242118;10614.363138211733;10746.46267686597;7147.3210045045635;7303.488755787044;7385.261473852786;7409.592472414069;7451.2921272479025;9094.727158185266;10172.389656620626;10235.539400726837;10271.435071071162;10321.74195645115 09:26:53 INFO - PROCESS | 26643 | |3;mootools.html;1274.9171303865241;1432.9211893345864;1437.331640787034;1604.6549991751779;1801.0544464156308;7373.926260737391;7544.547327160374;7561.508501947376;7570.318671319594;7604.885926711104;7481;7655.808604784883;7664.386849052076;7671.424643151772;7677.6161191940455;1903.0960293860376;2167.7398712154563;2232.843700940935;2275.2377953385594;2295.6556516522487;2250.4598896264943;2258.288639078685;2258.6950761647213;2259.367377134405;2263.287064574662;2193.3748881568754;2259.5706815705043;2261.8642881427086;2263.4680850000236;2265;2240.1487434774845;2247.7752224777555;2255.289583781112;2276.4536511237184;2284.314705588317;2222.811061059812;2222.9333120006427;2235.16181431963;2237.2728863119387;2291.6104262275453;7751.302382785577;7800.336971357385;7811.140774514799;7811.804704882366;7815.960920195363;4486.596206341413;4566.49768525462;4591.4260717410325;4594.839180628695;4599.08018396322;2876.5972763813083;2964.8665810038383;3013.1563162314587;3014.427258820817;3016.9849150754108;957.4877440569331;961.0965692249264;963.8216929867997;974.1086905481476;993.1855878179896;10562.155027597773;10582.259241853073;10593.576256949713;10602.840957385646;10604.727432708047;4214.620684138442;4306.074194048295;4330.133973205371;4372.060007098489;4377.430933978562;9028.18746312835;9095.272378209727;9096.954515227513;9115.772105697279;9120.954395228115;4086.570910054461;4589.5181005994555;4595.770211489412;4599.356090147382;4602.286645569942;4100.897477563025;4218.093109981307;4228.302330115496;4229.703920725581;4230.49234091911;3563.6792688658147;3621.6921561667027;3624.4019736743144;3642.3261696586214;3707.332680117605;1203.789336866045;1214.3260490427722;1215.6899990502366;1227.6010296653444;1228.7603917236231;938.7559234599054;966.2656381150235;1163.1799581295168;1166.1836714300025;1172.2087590876124;7101.644917754092;7127.714891404389;7144.1784194818265;7155.89266161008;7172.748953786592;1065.7868426314767;1114.3870871020906;1127.0926903842485;1132.0773569540797;1150.4075401168404;5467.234587157801;5487.368952570506;5524.088525393265;5525.033119204204;5532.2531458253425;8595;9189.586468608928;9207.861882071775;9278.11857873501;9288.767780805534;9176.220021298132;9187.908120918706;9226.630934762534;9415.952920235355;9542.379745316672;6900.413464855443;7052.753153639598;7069.08101946754;7099.6450177490915;7330.890036649348;6934.930650693428;7040.683169257498;7043.647817609201;7050.330218629222;7064.682089305891;8084.63619137152;8208.138145494637;8438.620262088343;8520.829583408422;8553.486790792573;8690.608922598372;8882.245009174292;8882.955585222033;8884.111588841064;8892.911070889468;5923.822285331447;6336.17629708135;6490.643014634241;6512.869742605027;6707.5975441473665;7197.604131772803;7236.96381518089;7258.056452661121;7273.636318184175;7291.489595728461;6312.390340463153;6421.325760795236;6481.189851268591;6549.083128362128;6577.868442631217;6387.489000880011;6410.358804384699;6447.194100737408;6483.189601299838;6505.5446118773125;6698.83252918681;6740.056392105012;6759.966200169164;6818.829529261808;6838.418734407631;6152.384761523812;6198;6208.255009398901;6243.37672205239;6246.437820596168;6385.96807015962;6392.808215753349;6436.0989461476365;6443.355664433519;6448.548601597843 09:26:53 INFO - PROCESS | 26643 | |4;prototype.html;316.0802065987974;320.6168628488956;321.8503395920897;326.3815070441515;328.16645719871514;5271.81548645797;5368;5373.086575282202;5382.058139825534;5383.946160538403;5295.232191332255;5297.417284098756;5312.946870531303;5319.0957537218665;5332.813351532697;3949.4273330367078;4064.756114633117;4136.917261654765;4143.274926887798;4163.708540402173;4184.100418410041;4186.413902053715;4187.078842654626;4187.518435379925;4189.916201675965;4132.462779838616;4139.586041395866;4139.7930103494855;4143.502779666444;4144.8134833932545;3935.0752573145287;4037.5356833964174;4038.8788336349958;4047.5547689754103;4151.875443736692;3561.6438356164176;3562.4656301554714;3577.928441431183;3599.5140656011367;3608.6210947850623;4994.101061808873;5020.573251273646;5039.596832253411;5044.780296669491;5055.266986287004;4729.810807567693;4733.384659994179;4737.597304229144;4737.73942433166;4751.857444276678;5590.9592998555645;5590.972045139748;5608.214849921014;5610.13042978339;5617.943820561783;3928.2339943710986;3932.7640341579313;3942.960570394288;3943.921121577552;3944.7830369329677;5615.438456154393;5840.47435730782;5849.385814489502;5873.089671100986;5910.615809972338;4079.143379890197;4130.56629053945;4139.81370838307;4152.1280531088205;4155.293600087993;4197.874063778091;4207.410962465257;4212.283911734951;4219.261629214875;4224.302990006615;4768;4771.809127634856;4776.5701086902345;4778.689385189951;4785.3300537924715;5594.720263986866;5610.186522954149;5615.578831587647;5616.354119276336;5618.213450116987;1464.7436698577706;1487.226642146078;1487.7470829958934;1488.1368806092441;1493.3951749541452;966.5215718219526;1003.3127307794184;1004.9748756281151;1006.7231511334295;1039.18424037132;4783;4885.511448855086;4909.189983652729;4914.999999999928;4923.950760492421;5679.574031947621;5765.4522820332;5816.709164541756;5819.4762471376935;5823.82528524145;4910.852674419773;4923.261510773341;4925.901481970341;4947.035328111056;4958.305837182797;3094.3501864608684;3128.5463607776746;3131.091983324856;3132.545780861762;3134.451470992567;5518.061929471999;5521.033819081645;5522.66863988162;5530.032244357221;5535.861603459865;5790.855228619318;5988.461038506555;5994.460498555151;5998.610090344114;6014.1580178775;5524.281843360337;5539.8892022158525;5546.140348246028;5553.972230138905;5556.333240011225;5767.509761670305;5833.67914764692;5849.415058494286;5859.94140058594;5861.912071318849;5710.086386178192;5711.086226203787;5713.143028545752;5725.541956643375;5727.799527016535;5525.281713377235;5533.391326953952;5533.612647114664;5541.418151094077;5543;3925.3523168676847;3981.964689180776;3995.1610161866333;4021.8793436195792;4031.2945234584417;5810.360860305278;5842.970785146047;5843.970780146242;5846.970765146147;5849.444302791228;5636.915446268227;5637.605367624227;5642.520385767256;5651.208830763614;5652.971735141298;5588.3573389060775;5609.887802244014;5614.747336369955;5639.154126881001;5653.547716182778;5498.477644623755;5500.972495137498;5549.833504994856;5559.694216818114;5561.916571251353;5458.8908221834545;5663.716814159358;5664.971675141763;5682.801101961411;5683.943160568507;5540.113581826889;5554.111342185231;5559.082751345983;5563.944360556343;5566.192902029264 09:26:53 INFO - PROCESS | 26643 | |5;yui.html;649.3182158733332;723.0528008309116;739.7078154129119;744.9590272535011;777.1994845309326;11803.822942655866;11968.34174120423;13277;13437.32813359333;13516.729665406687;13342.799858002138;13408.994325425609;13423.060385773;13465.730685386286;13526.594202173927;645.4126744662358;805.3959530352236;811.5009269299397;820.5568992743941;820.63481750621;817.1909809288791;820.5979070255592;821.0475848016303;823.8599438095508;827.9710210142646;863.3913091270671;871.0984131423977;871.2246100970142;871.2420194430822;871.4161511787117;674.3896773420063;842.3513894301415;859.5530324231396;860.8536548786722;862.4868203418956;630.5145038320513;632.7627139822566;632.9715162817685;633.1768700689086;633.297040285283;11900.107491938053;11973;12008.03935685152;12010.819837702442;12015.459304331325;11454.370009649467;11831.467583958742;11838.704032399173;11930.821037684442;12100.213486123374;9727.805443891153;9746.658866939693;9801.852972205423;9935.602575896955;9967.950160249226;3261.8858339957987;3311.61916379617;3327.683870032343;3389.8983030508875;3395.134240768613;44310.778446107564;44478.77760611176;44527.77736111331;44735.32897006548;45025.32462013073;9379.484128373006;9438.433693978383;9439.76400589977;9463.148316651397;9507.714768556954;17091.230894609525;17144.314227430765;17162.914185429243;17172.22724977379;17241.482755517354;6004.42957918997;6035.39646035393;6119.959606866843;6138.987067133873;6141.109539116803;3330.966690333114;3458.844352004166;3470.514128022079;3484.8780292689635;3501.1947252132154;2635.868206589663;2664.0675763482627;2669.5461771498503;2676.652035235407;2684.530207213769;492.2861850317055;508.48134902399346;509.42435048395816;512.3007095314869;516.2720564004735;583.5011065538903;608.9465225160498;640.2573015302227;651.563452486835;672.7208208593477;8046.316063134582;8054.718084867001;8223.712170074019;8247.876281855777;8278.337732981347;642.6722371590522;644.5842431631571;654.9279579246279;662.9171353580803;663.0981864664053;3866.74866133706;3890.144168282973;3909.5113110861143;4077.3883917412627;4111.773852438085;52271;52315.73842130765;52367;52462.73768631209;52496.47503524916;44736.55263447389;44791.77604112024;44807.32789008167;45334.31998520025;46062.539374606495;40055.59944400519;41875;42096;42416.1516769669;42518;8106.392020598597;8226.62980165882;8298.543580103153;8313.210245026712;8403.915960840313;31292.843535783086;31298.374032519678;31969.360612788078;32039.359212815147;32265.193370165933;38029.61970380371;39648;39670;39825.40261896016;40406.595934041456;11467.942660286646;11507.827382589101;11529.884701152881;11653.825192622287;11857.16999810005;11805.940970295094;11825.940870295593;12044.578439754567;12167.695807604881;12449;10812.45937703096;11065.170112241452;11078.446077696244;11341.603043893425;11768.35274059935;11020.944895275472;11098;11312.886871131512;11612.361320127475;11881.524739010343;10964.451777411257;10967.616133435291;11135.83296250573;11197.272177308449;11237.101031917264;9451.574679139318;9635.5663995119;9871.901280987386;10013;10093.899061009295;8716.956415217883;8747.212750852454;8752.21230089295;8992.685256016008;9142.771430714285 09:26:53 INFO - PROCESS | 26643 | __end_tp_report 09:26:53 INFO - PROCESS | 26643 | __start_cc_report 09:26:53 INFO - PROCESS | 26643 | _x_x_mozilla_cycle_collect,1012 09:26:53 INFO - PROCESS | 26643 | __end_cc_report 09:26:53 INFO - PROCESS | 26643 | __startTimestamp1459528013795__endTimestamp 09:26:53 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | ------- Summary: start ------- 09:26:53 INFO - PROCESS | 26643 | Number of tests: 6 09:26:53 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | [#0] dojo.html Cycles:165 Average:4648.50 Median:4778.28 stddev:469.83 (9.8%) stddev-sans-first:444.49 09:26:53 INFO - PROCESS | 26643 | Values: 2655.2 2737.4 2750.4 2755.5 2778.1 4550.5 4633.6 4718.4 4722.9 4730.3 4665.9 4690.3 4692.0 4772.5 4778.3 4251.0 4266.5 4284.7 4302.0 4465.8 4405.8 4421.6 4428.6 4476.4 4486.9 4219.1 4302.4 4311.8 4378.5 4378.8 4331.5 4336.7 4381.8 4382.3 4392.7 4321.8 4325.2 4332.0 4345.4 4365.6 4458.6 4533.4 4544.5 4615.3 4626.2 4980.0 4982.3 4988.7 4989.0 5008.5 5005.3 5011.3 5017.7 5021.2 5061.5 4557.7 4681.9 4692.2 4776.0 4777.0 5161.2 5166.0 5179.4 5179.8 5198.0 4945.7 4950.8 4951.2 4954.1 4995.3 4947.8 4949.6 4999.9 5044.2 5056.9 4958.8 4993.1 5002.2 5004.3 5048.9 4799.3 4996.6 5003.4 5006.3 5057.4 4212.3 4257.2 4262.9 4301.8 4307.2 3726.6 3733.9 3737.8 3738.2 3776.3 4215.9 4308.8 4329.3 4330.0 4357.0 5014.9 5058.6 5071.0 5101.9 5106.5 4312.8 4331.7 4333.3 4335.5 4358.0 4445.3 4476.6 4564.2 4572.7 4603.1 4773.9 4789.5 4797.7 4800.5 4853.8 5066.9 5066.9 5073.4 5084.3 5113.7 4629.5 4630.0 4698.9 4743.4 4848.6 4963.6 4984.9 4985.6 5002.9 5023.7 5033.8 5048.5 5051.0 5053.7 5074.3 4806.0 4825.0 4886.9 4892.7 4960.4 4819.4 4828.5 4850.3 4868.4 4888.0 4763.3 4764.4 4773.9 4784.4 4825.8 4804.2 4875.4 4892.2 4961.0 4987.9 4792.3 4794.3 4806.9 4815.2 4857.4 09:26:53 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | [#1] ext.html Cycles:180 Average:38863.45 Median:20146.37 stddev:61504.04 (305.3%) stddev-sans-first:61609.26 09:26:53 INFO - PROCESS | 26643 | Values: 538.9 541.0 544.3 556.0 566.7 26683.2 33725.3 34340.5 34369.3 34438.0 37130.4 37569.6 37586.6 37634.4 37661.1 7565.1 7725.7 7735.7 7738.0 7741.0 7641.3 7753.2 7760.3 7778.5 7960.9 7880.5 7965.6 7975.4 7976.2 7977.1 7883.9 7961.4 7966.4 7975.0 7978.2 7778.8 7893.2 7905.1 7908.8 7909.3 37571.2 37908.2 38087.8 38140.2 38140.4 3216.3 3287.6 3557.2 3645.7 3724.3 28447.0 29339.0 29367.9 29373.7 29432.3 3441.7 3470.9 3554.9 3571.0 3579.0 238978.0 239266.0 240047.0 240362.8 240366.0 46611.3 53173.2 53604.0 53605.2 55313.4 48627.3 48842.3 48901.8 48912.5 48978.5 12981.8 13117.2 13146.9 13221.5 13235.5 9715.0 9733.9 9795.3 9822.9 9837.3 16096.4 16502.0 18283.6 18536.0 18697.9 6656.5 6852.9 7038.3 7055.8 7250.6 817.5 883.8 940.3 940.4 941.3 23055.5 23263.4 23371.9 23434.8 23483.6 948.8 961.6 966.4 976.7 984.1 12964.4 13145.2 13388.7 13391.2 13430.3 276211.0 280917.0 281590.0 282071.0 282684.0 47310.3 47618.8 47662.8 47692.8 47698.5 1051.3 1186.8 1230.2 1240.2 1240.3 24255.4 24606.9 24625.0 24722.3 24977.5 37439.1 37616.8 37831.4 37867.0 37877.2 173687.0 174204.0 174568.1 174780.0 174907.1 26418.9 30339.2 31052.1 31082.4 31189.2 36363.3 38262.4 38394.2 38409.4 38728.6 35832.6 36647.0 37083.6 37207.8 37370.6 31332.0 31350.5 31686.2 31700.4 31712.0 32208.8 32276.4 32898.7 32912.0 32939.5 28827.3 28849.3 28969.4 28976.1 29165.7 23276.2 23304.4 23519.9 23549.2 23683.2 09:26:53 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | [#2] jquery.html Cycles:180 Average:22886.72 Median:23445.49 stddev:63249.91 (269.8%) stddev-sans-first:63404.68 09:26:53 INFO - PROCESS | 26643 | Values: 338.8 339.7 347.0 354.4 361.9 15150.0 15547.8 16269.2 16864.5 16884.9 15939.2 16102.1 17082.9 17098.8 17118.9 4993.5 5084.6 5127.9 5129.5 5145.2 4951.5 5119.9 5140.0 5155.7 5164.0 5093.1 5100.5 5103.3 5106.0 5116.2 5008.2 5201.2 5202.6 5208.1 5216.8 4996.1 5018.9 5026.3 5027.1 5027.3 15132.5 19012.6 19974.7 19995.3 20001.5 1912.6 1930.8 1939.8 2027.7 2470.1 9320.3 9440.0 9581.3 10360.8 12104.9 1749.4 1778.6 1785.3 1793.8 1808.6 56450.7 59239.7 60005.7 60224.0 60920.0 9380.8 9501.9 9607.4 9747.6 10178.8 13117.9 13239.5 13257.2 13262.9 13280.2 6388.7 6451.9 6707.9 6804.7 6817.5 6119.6 6163.4 6220.0 6223.7 6256.7 4174.2 4188.4 4227.5 4277.2 4331.1 1743.3 1786.4 1800.3 1801.3 1819.5 894.3 927.0 955.9 971.0 973.8 15613.5 15756.4 15902.9 16163.7 16178.4 831.7 845.3 857.3 895.8 927.1 9180.0 9217.5 9229.0 9361.8 9399.8 376101.0 383757.2 384841.0 392100.0 393783.0 47538.5 60992.0 62824.0 68548.7 70200.3 887.5 913.5 918.0 927.0 931.9 13840.8 14018.0 14184.0 14252.6 14405.8 28564.6 29734.3 30333.8 30996.7 31594.7 41497.4 42613.8 42991.6 44589.0 44690.3 7323.0 7404.2 7432.7 7439.0 7467.6 10465.3 11388.1 11693.9 11786.4 12167.4 10209.4 10397.9 10402.2 10504.4 10530.3 9779.4 10316.4 10446.5 10450.7 10555.8 10461.7 10473.3 10605.8 10614.4 10746.5 7147.3 7303.5 7385.3 7409.6 7451.3 9094.7 10172.4 10235.5 10271.4 10321.7 09:26:53 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | [#3] mootools.html Cycles:180 Average:5340.89 Median:6361.07 stddev:2781.27 (43.7%) stddev-sans-first:2772.28 09:26:53 INFO - PROCESS | 26643 | Values: 1274.9 1432.9 1437.3 1604.7 1801.1 7373.9 7544.5 7561.5 7570.3 7604.9 7481.0 7655.8 7664.4 7671.4 7677.6 1903.1 2167.7 2232.8 2275.2 2295.7 2250.5 2258.3 2258.7 2259.4 2263.3 2193.4 2259.6 2261.9 2263.5 2265.0 2240.1 2247.8 2255.3 2276.5 2284.3 2222.8 2222.9 2235.2 2237.3 2291.6 7751.3 7800.3 7811.1 7811.8 7816.0 4486.6 4566.5 4591.4 4594.8 4599.1 2876.6 2964.9 3013.2 3014.4 3017.0 957.5 961.1 963.8 974.1 993.2 10562.2 10582.3 10593.6 10602.8 10604.7 4214.6 4306.1 4330.1 4372.1 4377.4 9028.2 9095.3 9097.0 9115.8 9121.0 4086.6 4589.5 4595.8 4599.4 4602.3 4100.9 4218.1 4228.3 4229.7 4230.5 3563.7 3621.7 3624.4 3642.3 3707.3 1203.8 1214.3 1215.7 1227.6 1228.8 938.8 966.3 1163.2 1166.2 1172.2 7101.6 7127.7 7144.2 7155.9 7172.7 1065.8 1114.4 1127.1 1132.1 1150.4 5467.2 5487.4 5524.1 5525.0 5532.3 8595.0 9189.6 9207.9 9278.1 9288.8 9176.2 9187.9 9226.6 9416.0 9542.4 6900.4 7052.8 7069.1 7099.6 7330.9 6934.9 7040.7 7043.6 7050.3 7064.7 8084.6 8208.1 8438.6 8520.8 8553.5 8690.6 8882.2 8883.0 8884.1 8892.9 5923.8 6336.2 6490.6 6512.9 6707.6 7197.6 7237.0 7258.1 7273.6 7291.5 6312.4 6421.3 6481.2 6549.1 6577.9 6387.5 6410.4 6447.2 6483.2 6505.5 6698.8 6740.1 6760.0 6818.8 6838.4 6152.4 6198.0 6208.3 6243.4 6246.4 6386.0 6392.8 6436.1 6443.4 6448.5 09:26:53 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | [#4] prototype.html Cycles:180 Average:4667.60 Median:5296.32 stddev:1361.21 (25.7%) stddev-sans-first:1325.26 09:26:53 INFO - PROCESS | 26643 | Values: 316.1 320.6 321.9 326.4 328.2 5271.8 5368.0 5373.1 5382.1 5383.9 5295.2 5297.4 5312.9 5319.1 5332.8 3949.4 4064.8 4136.9 4143.3 4163.7 4184.1 4186.4 4187.1 4187.5 4189.9 4132.5 4139.6 4139.8 4143.5 4144.8 3935.1 4037.5 4038.9 4047.6 4151.9 3561.6 3562.5 3577.9 3599.5 3608.6 4994.1 5020.6 5039.6 5044.8 5055.3 4729.8 4733.4 4737.6 4737.7 4751.9 5591.0 5591.0 5608.2 5610.1 5617.9 3928.2 3932.8 3943.0 3943.9 3944.8 5615.4 5840.5 5849.4 5873.1 5910.6 4079.1 4130.6 4139.8 4152.1 4155.3 4197.9 4207.4 4212.3 4219.3 4224.3 4768.0 4771.8 4776.6 4778.7 4785.3 5594.7 5610.2 5615.6 5616.4 5618.2 1464.7 1487.2 1487.7 1488.1 1493.4 966.5 1003.3 1005.0 1006.7 1039.2 4783.0 4885.5 4909.2 4915.0 4924.0 5679.6 5765.5 5816.7 5819.5 5823.8 4910.9 4923.3 4925.9 4947.0 4958.3 3094.4 3128.5 3131.1 3132.5 3134.5 5518.1 5521.0 5522.7 5530.0 5535.9 5790.9 5988.5 5994.5 5998.6 6014.2 5524.3 5539.9 5546.1 5554.0 5556.3 5767.5 5833.7 5849.4 5859.9 5861.9 5710.1 5711.1 5713.1 5725.5 5727.8 5525.3 5533.4 5533.6 5541.4 5543.0 3925.4 3982.0 3995.2 4021.9 4031.3 5810.4 5843.0 5844.0 5847.0 5849.4 5636.9 5637.6 5642.5 5651.2 5653.0 5588.4 5609.9 5614.7 5639.2 5653.5 5498.5 5501.0 5549.8 5559.7 5561.9 5458.9 5663.7 5665.0 5682.8 5683.9 5540.1 5554.1 5559.1 5563.9 5566.2 09:26:53 INFO - PROCESS | 26643 | 09:26:53 INFO - PROCESS | 26643 | [#5] yui.html Cycles:180 Average:12782.14 Median:44735.94 stddev:14354.17 (32.1%) stddev-sans-first:14365.52 09:26:53 INFO - PROCESS | 26643 | Values: 649.3 723.1 739.7 745.0 777.2 11803.8 11968.3 13277.0 13437.3 13516.7 13342.8 13409.0 13423.1 13465.7 13526.6 645.4 805.4 811.5 820.6 820.6 817.2 820.6 821.0 823.9 828.0 863.4 871.1 871.2 871.2 871.4 674.4 842.4 859.6 860.9 862.5 630.5 632.8 633.0 633.2 633.3 11900.1 11973.0 12008.0 12010.8 12015.5 11454.4 11831.5 11838.7 11930.8 12100.2 9727.8 9746.7 9801.9 9935.6 9968.0 3261.9 3311.6 3327.7 3389.9 3395.1 44310.8 44478.8 44527.8 44735.3 45025.3 9379.5 9438.4 9439.8 9463.1 9507.7 17091.2 17144.3 17162.9 17172.2 17241.5 6004.4 6035.4 6120.0 6139.0 6141.1 3331.0 3458.8 3470.5 3484.9 3501.2 2635.9 2664.1 2669.5 2676.7 2684.5 492.3 508.5 509.4 512.3 516.3 583.5 608.9 640.3 651.6 672.7 8046.3 8054.7 8223.7 8247.9 8278.3 642.7 644.6 654.9 662.9 663.1 3866.7 3890.1 3909.5 4077.4 4111.8 52271.0 52315.7 52367.0 52462.7 52496.5 44736.6 44791.8 44807.3 45334.3 46062.5 40055.6 41875.0 42096.0 42416.2 42518.0 8106.4 8226.6 8298.5 8313.2 8403.9 31292.8 31298.4 31969.4 32039.4 32265.2 38029.6 39648.0 39670.0 39825.4 40406.6 11467.9 11507.8 11529.9 11653.8 11857.2 11805.9 11825.9 12044.6 12167.7 12449.0 10812.5 11065.2 11078.4 11341.6 11768.4 11020.9 11098.0 11312.9 11612.4 11881.5 10964.5 10967.6 11135.8 11197.3 11237.1 9451.6 9635.6 9871.9 10013.0 10093.9 8717.0 8747.2 8752.2 8992.7 9142.8 09:26:53 INFO - PROCESS | 26643 | -------- Summary: end -------- 09:26:53 INFO - PROCESS | 26643 | 09:26:54 INFO - TEST-INFO | 26643: exit 0 09:26:54 INFO - TEST-OK | dromaeo_css | took 1118036ms 09:26:54 INFO - TEST-START | kraken 09:26:54 INFO - operating with platform_type : linux_ 09:26:54 INFO - Initialising browser for kraken test... 09:26:54 INFO - TEST-INFO | started process 26828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE8BfZS/profile http://localhost:39476/getInfo.html) 09:26:59 INFO - PROCESS | 26828 | __metrics Screen width/height:1600/1200 09:26:59 INFO - PROCESS | 26828 | colorDepth:24 09:26:59 INFO - PROCESS | 26828 | Browser inner width/height: 1024/697 09:26:59 INFO - PROCESS | 26828 | __metrics 09:27:00 ERROR - PROCESS | 26828 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:27:01 INFO - TEST-INFO | 26828: exit 0 09:27:01 INFO - Browser initialized. 09:27:01 INFO - Running cycle 1/1 for kraken test... 09:27:01 INFO - TEST-INFO | started process 26911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE8BfZS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:12 INFO - PROCESS | 26911 | RSS: Main: 154054656 09:27:12 INFO - PROCESS | 26911 | 09:27:15 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39476/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:16 INFO - PROCESS | 26911 | RSS: Main: 196526080 09:27:16 INFO - PROCESS | 26911 | 09:27:18 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39476/tests/kraken/driver.html?testName=audio-dft) 09:27:19 INFO - PROCESS | 26911 | RSS: Main: 186011648 09:27:19 INFO - PROCESS | 26911 | 09:27:22 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39476/tests/kraken/driver.html?testName=audio-fft) 09:27:23 INFO - PROCESS | 26911 | RSS: Main: 170680320 09:27:23 INFO - PROCESS | 26911 | 09:27:25 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39476/tests/kraken/driver.html?testName=audio-oscillator) 09:27:25 INFO - PROCESS | 26911 | RSS: Main: 171925504 09:27:25 INFO - PROCESS | 26911 | 09:27:27 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:28 INFO - PROCESS | 26911 | RSS: Main: 173469696 09:27:28 INFO - PROCESS | 26911 | 09:27:31 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39476/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:32 INFO - PROCESS | 26911 | RSS: Main: 173867008 09:27:32 INFO - PROCESS | 26911 | 09:27:35 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39476/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:36 INFO - PROCESS | 26911 | RSS: Main: 173060096 09:27:36 INFO - PROCESS | 26911 | 09:27:39 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39476/tests/kraken/driver.html?testName=json-parse-financial) 09:27:39 INFO - PROCESS | 26911 | RSS: Main: 174211072 09:27:39 INFO - PROCESS | 26911 | 09:27:41 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:41 INFO - PROCESS | 26911 | RSS: Main: 184729600 09:27:41 INFO - PROCESS | 26911 | 09:27:43 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39476/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:44 INFO - PROCESS | 26911 | RSS: Main: 182894592 09:27:44 INFO - PROCESS | 26911 | 09:27:46 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:47 INFO - PROCESS | 26911 | RSS: Main: 197660672 09:27:47 INFO - PROCESS | 26911 | 09:27:49 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:27:50 INFO - PROCESS | 26911 | RSS: Main: 201175040 09:27:50 INFO - PROCESS | 26911 | 09:27:52 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:53 INFO - PROCESS | 26911 | RSS: Main: 200585216 09:27:53 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:39476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39476/tests/kraken/driver.html?testName=ai-astar) 09:27:55 INFO - PROCESS | 26911 | RSS: Main: 261607424 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | __start_tp_report 09:27:55 INFO - PROCESS | 26911 | _x_x_mozilla_page_load 09:27:55 INFO - PROCESS | 26911 | _x_x_mozilla_page_load_details 09:27:55 INFO - PROCESS | 26911 | |i|pagename|runs| 09:27:55 INFO - PROCESS | 26911 | |0;ai-astar;112;112;106;110;112;111;100;112;112;112 09:27:55 INFO - PROCESS | 26911 | |1;audio-beat-detection;172;131;157;168;140;156;160;136;185;135 09:27:55 INFO - PROCESS | 26911 | |2;audio-dft;160;162;159;161;160;160;161;161;160;161 09:27:55 INFO - PROCESS | 26911 | |3;audio-fft;77;73;96;99;74;74;72;99;96;75 09:27:55 INFO - PROCESS | 26911 | |4;audio-oscillator;95;95;141;95;95;94;140;95;94;144 09:27:55 INFO - PROCESS | 26911 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;117 09:27:55 INFO - PROCESS | 26911 | |6;imaging-darkroom;146;147;147;147;146;147;147;147;145;148 09:27:55 INFO - PROCESS | 26911 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;96 09:27:55 INFO - PROCESS | 26911 | |8;json-parse-financial;64;64;65;64;66;64;64;74;62;62 09:27:55 INFO - PROCESS | 26911 | |9;json-stringify-tinderbox;63;64;64;64;64;64;64;64;66;65 09:27:55 INFO - PROCESS | 26911 | |10;stanford-crypto-aes;81;82;82;82;83;90;82;82;82;83 09:27:55 INFO - PROCESS | 26911 | |11;stanford-crypto-ccm;120;118;115;116;114;116;114;132;116;122 09:27:55 INFO - PROCESS | 26911 | |12;stanford-crypto-pbkdf2;148;144;138;138;139;133;150;140;140;140 09:27:55 INFO - PROCESS | 26911 | |13;stanford-crypto-sha256-iterative;68;69;70;69;67;68;68;70;72;68 09:27:55 INFO - PROCESS | 26911 | __end_tp_report 09:27:55 INFO - PROCESS | 26911 | __start_cc_report 09:27:55 INFO - PROCESS | 26911 | _x_x_mozilla_cycle_collect,1152 09:27:55 INFO - PROCESS | 26911 | __end_cc_report 09:27:55 INFO - PROCESS | 26911 | __startTimestamp1459528075344__endTimestamp 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | ------- Summary: start ------- 09:27:55 INFO - PROCESS | 26911 | Number of tests: 14 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:3.96 (3.5%) stddev-sans-first:4.12 09:27:55 INFO - PROCESS | 26911 | Values: 112.0 112.0 106.0 110.0 112.0 111.0 100.0 112.0 112.0 112.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:158.50 stddev:18.07 (11.4%) stddev-sans-first:17.96 09:27:55 INFO - PROCESS | 26911 | Values: 172.0 131.0 157.0 168.0 140.0 156.0 160.0 136.0 185.0 135.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 09:27:55 INFO - PROCESS | 26911 | Values: 160.0 162.0 159.0 161.0 160.0 160.0 161.0 161.0 160.0 161.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#3] audio-fft Cycles:10 Average:83.50 Median:86.50 stddev:12.16 (14.1%) stddev-sans-first:12.67 09:27:55 INFO - PROCESS | 26911 | Values: 77.0 73.0 96.0 99.0 74.0 74.0 72.0 99.0 96.0 75.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:95.00 stddev:22.70 (23.9%) stddev-sans-first:23.53 09:27:55 INFO - PROCESS | 26911 | Values: 95.0 95.0 141.0 95.0 95.0 94.0 140.0 95.0 94.0 144.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:27:55 INFO - PROCESS | 26911 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 09:27:55 INFO - PROCESS | 26911 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 145.0 148.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:27:55 INFO - PROCESS | 26911 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.00 stddev:3.41 (5.3%) stddev-sans-first:3.61 09:27:55 INFO - PROCESS | 26911 | Values: 64.0 64.0 65.0 64.0 66.0 64.0 64.0 74.0 62.0 62.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 09:27:55 INFO - PROCESS | 26911 | Values: 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 66.0 65.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:2.56 (3.1%) stddev-sans-first:2.62 09:27:55 INFO - PROCESS | 26911 | Values: 81.0 82.0 82.0 82.0 83.0 90.0 82.0 82.0 82.0 83.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:117.00 stddev:5.46 (4.7%) stddev-sans-first:5.75 09:27:55 INFO - PROCESS | 26911 | Values: 120.0 118.0 115.0 116.0 114.0 116.0 114.0 132.0 116.0 122.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:140.00 stddev:5.03 (3.6%) stddev-sans-first:4.66 09:27:55 INFO - PROCESS | 26911 | Values: 148.0 144.0 138.0 138.0 139.0 133.0 150.0 140.0 140.0 140.0 09:27:55 INFO - PROCESS | 26911 | 09:27:55 INFO - PROCESS | 26911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.50 09:27:55 INFO - PROCESS | 26911 | Values: 68.0 69.0 70.0 69.0 67.0 68.0 68.0 70.0 72.0 68.0 09:27:55 INFO - PROCESS | 26911 | -------- Summary: end -------- 09:27:55 INFO - PROCESS | 26911 | 09:27:56 INFO - TEST-INFO | 26911: exit 0 09:27:56 INFO - TEST-OK | kraken | took 61773ms 09:27:56 INFO - SUITE-END | took 1179s 09:27:56 INFO - Completed test suite (00:19:39) 09:27:56 INFO - javascript benchmark 09:27:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2655.1901669990652, 2737.3704048068944, 2750.40866213764, 2755.517784387732, 2778.124890659442, 4550.544945505448, 4633.5598118178805, 4718.363020992165, 4722.8583142505695, 4730.290456431533, 4665.9066818663605, 4690.296455531672, 4691.976540117304, 4772.522747725226, 4778.283257511375, 4251.043515209069, 4266.530681625019, 4284.721493102938, 4301.956980430187, 4465.754383508905, 4405.757683327432, 4421.57994990477, 4428.601425871687, 4476.440444944382, 4486.8878278042985, 4219.135077309144, 4302.397664326997, 4311.805968731414, 4378.474583050054, 4378.8029538670835, 4331.45856767904, 4336.739795612273, 4381.75900325482, 4382.342648602735, 4392.670549708785, 4321.82712691492, 4325.243082460557, 4331.9783401083105, 4345.391645169679, 4365.607095361401, 4458.576435238647, 4533.410656614652, 4544.454665440136, 4615.307703844416, 4626.236670949289, 4979.950200497985, 4982.327385802942, 4988.725620090893, 4989.027139707759, 5008.54923056923, 5005.3242812220615, 5011.298418221452, 5017.67385119966, 5021.246812978046, 5061.468545802674, 4557.749323787223, 4681.882952926136, 4692.155412025868, 4775.952240477551, 4777.044591081728, 5161.225816127611, 5166.0, 5179.352580927384, 5179.81870634526, 5198.0, 4945.678530895552, 4950.777215025332, 4951.207806750975, 4954.083494553519, 4995.300657907896, 4947.802087916443, 4949.554540091409, 4999.875003124878, 5044.192929131322, 5056.924146137811, 4958.776855041532, 4993.051320249141, 5002.2496625506465, 5004.349434573555, 5048.899022019539, 4799.280107983761, 4996.550310472002, 5003.449620541737, 5006.274090256892, 5057.367829021372, 4212.30496968003, 4257.1698518788535, 4262.893427664271, 4301.827926882952, 4307.203167414038, 3726.6087060858217, 3733.8506459741307, 3737.775733455947, 3738.158914244273, 3776.2825063238447, 4215.852445164466, 4308.784560771949, 4329.307310830252, 4330.004099057234, 4357.041450880801, 5014.924776128361, 5058.620603454756, 5070.974645126751, 5101.923471147936, 5106.46382129871, 4312.762798046075, 4331.6534677225745, 4333.328334108218, 4335.479742430865, 4358.0412309291905, 4445.310976798602, 4476.597106260452, 4564.178447879413, 4572.657050721209, 4603.079384123189, 4773.880652983565, 4789.4971028041555, 4797.664163508521, 4800.495947925488, 4853.757312134449, 5066.873328166826, 5066.923996139987, 5073.365829271341, 5084.339035925306, 5113.667611605234, 4629.513901040477, 4629.976850115728, 4698.906021879611, 4743.383360163295, 4848.612111031039, 4963.602911767122, 4984.925226121683, 4985.601151907911, 5002.949970500248, 5023.748812559431, 5033.798648054037, 5048.495150484922, 5051.0, 5053.67151135175, 5074.314967479343, 4805.951940480691, 4824.95175048245, 4886.92669609949, 4892.730899800546, 4960.355153829979, 4819.373481447389, 4828.49420002196, 4850.272459131159, 4868.41579010521, 4888.0, 4763.333133361401, 4764.356811830358, 4773.856784296477, 4784.4497882742535, 4825.782839772149, 4804.231322988445, 4875.43932447773, 4892.217245240744, 4960.950390496193, 4987.900241995212, 4792.281157826214, 4794.328793968777, 4806.8798280043275, 4815.22956327, 4857.441394239708], "unit": "score", "name": "dojo.html", "value": 4620.1955402614585}, {"lowerIsBetter": false, "replicates": [538.8922215556888, 540.9513143817055, 544.2815483561698, 555.9659034196394, 566.6628356128105, 26683.199504014887, 33725.32549349015, 34340.48489272663, 34369.31261374771, 34438.0, 37130.443043354375, 37569.62430375695, 37586.624133758654, 37634.43548346777, 37661.05847353818, 7565.054368203974, 7725.652345644431, 7735.690572377126, 7738.0, 7741.032370953631, 7641.3122818946285, 7753.185915478878, 7760.340371068438, 7778.49439786412, 7960.920390796105, 7880.5271683698875, 7965.60171991401, 7975.40184486163, 7976.202379762035, 7977.082635496934, 7883.921160788404, 7961.36309095271, 7966.44234903557, 7974.960125199366, 7978.242067003625, 7778.844423111563, 7893.210678932118, 7905.051393832719, 7908.762737117896, 7909.327707144899, 37571.248575028345, 37908.24183516342, 38087.80956095229, 38140.23719525622, 38140.42789358162, 3216.292415668549, 3287.621923478807, 3557.1996300832366, 3645.7447978641508, 3724.3296206682785, 28447.0, 29339.0, 29367.853160734274, 29373.70626293731, 29432.264193395124, 3441.690247877703, 3470.8785192518394, 3554.875579354736, 3571.0, 3579.0, 238978.0, 239266.0, 240047.0, 240362.7981860097, 240366.0, 46611.30083048757, 53173.202401964, 53604.0, 53605.1959220612, 55313.44686553083, 48627.27059094117, 48842.26736598954, 48901.75549122231, 48912.51087489151, 48978.51021489811, 12981.805272920914, 13117.212967221998, 13146.868531314565, 13221.537246196336, 13235.470581176838, 9714.951425242829, 9733.902660973441, 9795.265355098396, 9822.852657210147, 9837.262205334628, 16096.436624718313, 16502.0, 18283.63432731338, 18536.0, 18697.906510467634, 6656.5340426169705, 6852.862942741217, 7038.260982596754, 7055.788326350115, 7250.6374681265725, 817.5340056167927, 883.7613844262013, 940.3182692547985, 940.3793496292415, 941.3222479814523, 23055.53888922212, 23263.41841453977, 23371.88314058419, 23434.76565234326, 23483.647745283834, 948.8197242523898, 961.6345788600287, 966.4201479112617, 976.7069879036261, 984.1487113646788, 12964.351782410842, 13145.21128732279, 13388.732225355438, 13391.196528208338, 13430.26133562644, 276211.0, 280917.0, 281590.0, 282071.0, 282684.0, 47310.29034564484, 47618.761906190244, 47662.76168619135, 47692.7615361921, 47698.52301476941, 1051.30613794895, 1186.7804456175636, 1230.1573422205638, 1240.2434514945876, 1240.3116270469975, 24255.393615159763, 24606.876965615058, 24625.0, 24722.302762475072, 24977.50044999126, 37439.06402339855, 37616.81191594025, 37831.43252851154, 37867.0, 37877.242455151296, 173687.0, 174204.0, 174568.12715936848, 174780.0, 174907.12546437187, 26418.867905660347, 30339.241518962204, 31052.0684379469, 31082.378352432374, 31189.220269493446, 36363.27273454569, 38262.42606360851, 38394.23211535809, 38409.4238586427, 38728.6127138725, 35832.641673583974, 36647.0, 37083.629163708014, 37207.81396093002, 37370.626293736714, 31332.0, 31350.529742054343, 31686.207844804063, 31700.36599268048, 31712.0, 32208.838955806008, 32276.410638826746, 32898.67101329052, 32912.0, 32939.50590741093, 28827.279318017216, 28849.278768030967, 28969.378827646546, 28976.13071607855, 29165.7083429163, 23276.185333513247, 23304.417389564718, 23519.88240058789, 23549.154242193566, 23683.1710890118], "unit": "score", "name": "ext.html", "value": 16405.350046334166}, {"lowerIsBetter": false, "replicates": [338.8102662508994, 339.6874875114894, 346.98091604961735, 354.44529311627304, 361.88419705694173, 15149.999999999985, 15547.766783498242, 16269.186540672963, 16864.494065178034, 16884.915575422106, 15939.203039847991, 16102.114383708891, 17082.914585427054, 17098.82901170988, 17118.914405427957, 4993.475685053071, 5084.567811736007, 5127.871803204931, 5129.461406552315, 5145.228215767646, 4951.529604687549, 5119.897602047957, 5139.997700448414, 5155.71643559604, 5163.974180129113, 5093.057784309896, 5100.5154510321645, 5103.311053007852, 5105.974470127644, 5116.2069879168785, 5008.198688209887, 5201.193814958669, 5202.583793296527, 5208.062548741225, 5216.8174113906025, 4996.12567800637, 5018.949810501921, 5026.321446604698, 5027.095122877917, 5027.27104569839, 15132.5460236192, 19012.61974760497, 19974.70037949432, 19995.300164494318, 20001.499962500908, 1912.6270377276437, 1930.7774650120955, 1939.8254157125784, 2027.7161197432372, 2470.110760126353, 9320.300977426652, 9440.0, 9581.281403894665, 10360.79278414435, 12104.878951210463, 1749.4401791426749, 1778.5998150416183, 1785.2680401035643, 1793.8385545300855, 1808.6021075363399, 56450.717746411414, 59239.70380148115, 60005.6999715003, 60224.0, 60920.0, 9380.812383752424, 9501.857472137923, 9607.375520591138, 9747.61009559624, 10178.81155551545, 13117.934410327887, 13239.470421183045, 13257.204567725967, 13262.867371326356, 13280.203187808762, 6388.744450221939, 6451.935480645134, 6707.865842683119, 6804.693788779517, 6817.454603631698, 6119.571629985947, 6163.445289923839, 6219.968900155471, 6223.719932603044, 6256.749730010749, 4174.227767862955, 4188.434561334181, 4227.513835908849, 4277.1873344064525, 4331.090471001062, 1743.3264066496306, 1786.4015554789032, 1800.3428748506701, 1801.261482792049, 1819.5087326422056, 894.3024440936081, 926.9814603707888, 955.8566215067657, 970.9563069661882, 973.8247115519274, 15613.531594052196, 15756.369745210062, 15902.878355733736, 16163.676726465404, 16178.352865885468, 831.7380025292014, 845.3152946113545, 857.3312816003527, 895.8163576466809, 927.1007123090591, 9180.0, 9217.539123043822, 9229.0, 9361.765955851159, 9399.765005874771, 376101.0, 383757.16242837213, 384841.0, 392100.0, 393783.0, 47538.52461475341, 60992.0, 62824.0, 68548.6811413963, 70200.2979970204, 887.4586502233632, 913.456493386434, 917.9862302065475, 927.0266220468482, 931.9161275485238, 13840.792388114387, 14018.0, 14184.0, 14252.572422827332, 14405.7839132411, 28564.57153142663, 29734.25664358408, 30333.848330758206, 30996.69003309938, 31594.684053160094, 41497.37753933633, 42613.786931065144, 42991.57008429876, 44589.0, 44690.329645056, 7323.0, 7404.222556631476, 7432.665530051053, 7439.0, 7467.589282589292, 10465.319754215952, 11388.088952883914, 11693.941530292634, 11786.41067946582, 12167.391630418266, 10209.438480883326, 10397.948010260203, 10402.167826574007, 10504.422256775644, 10530.31552949056, 9779.364341317792, 10316.381017138996, 10446.52990615409, 10450.738731531772, 10555.841662374916, 10461.68614941553, 10473.31923424975, 10605.787884242118, 10614.363138211733, 10746.46267686597, 7147.3210045045635, 7303.488755787044, 7385.261473852786, 7409.592472414069, 7451.2921272479025, 9094.727158185266, 10172.389656620626, 10235.539400726837, 10271.435071071162, 10321.74195645115], "unit": "score", "name": "jquery.html", "value": 7881.821230768848}, {"lowerIsBetter": false, "replicates": [1274.9171303865241, 1432.9211893345864, 1437.331640787034, 1604.6549991751779, 1801.0544464156308, 7373.926260737391, 7544.547327160374, 7561.508501947376, 7570.318671319594, 7604.885926711104, 7481.0, 7655.808604784883, 7664.386849052076, 7671.424643151772, 7677.6161191940455, 1903.0960293860376, 2167.7398712154563, 2232.843700940935, 2275.2377953385594, 2295.6556516522487, 2250.4598896264943, 2258.288639078685, 2258.6950761647213, 2259.367377134405, 2263.287064574662, 2193.3748881568754, 2259.5706815705043, 2261.8642881427086, 2263.4680850000236, 2265.0, 2240.1487434774845, 2247.7752224777555, 2255.289583781112, 2276.4536511237184, 2284.314705588317, 2222.811061059812, 2222.9333120006427, 2235.16181431963, 2237.2728863119387, 2291.6104262275453, 7751.302382785577, 7800.336971357385, 7811.140774514799, 7811.804704882366, 7815.960920195363, 4486.596206341413, 4566.49768525462, 4591.4260717410325, 4594.839180628695, 4599.08018396322, 2876.5972763813083, 2964.8665810038383, 3013.1563162314587, 3014.427258820817, 3016.9849150754108, 957.4877440569331, 961.0965692249264, 963.8216929867997, 974.1086905481476, 993.1855878179896, 10562.155027597773, 10582.259241853073, 10593.576256949713, 10602.840957385646, 10604.727432708047, 4214.620684138442, 4306.074194048295, 4330.133973205371, 4372.060007098489, 4377.430933978562, 9028.18746312835, 9095.272378209727, 9096.954515227513, 9115.772105697279, 9120.954395228115, 4086.570910054461, 4589.5181005994555, 4595.770211489412, 4599.356090147382, 4602.286645569942, 4100.897477563025, 4218.093109981307, 4228.302330115496, 4229.703920725581, 4230.49234091911, 3563.6792688658147, 3621.6921561667027, 3624.4019736743144, 3642.3261696586214, 3707.332680117605, 1203.789336866045, 1214.3260490427722, 1215.6899990502366, 1227.6010296653444, 1228.7603917236231, 938.7559234599054, 966.2656381150235, 1163.1799581295168, 1166.1836714300025, 1172.2087590876124, 7101.644917754092, 7127.714891404389, 7144.1784194818265, 7155.89266161008, 7172.748953786592, 1065.7868426314767, 1114.3870871020906, 1127.0926903842485, 1132.0773569540797, 1150.4075401168404, 5467.234587157801, 5487.368952570506, 5524.088525393265, 5525.033119204204, 5532.2531458253425, 8595.0, 9189.586468608928, 9207.861882071775, 9278.11857873501, 9288.767780805534, 9176.220021298132, 9187.908120918706, 9226.630934762534, 9415.952920235355, 9542.379745316672, 6900.413464855443, 7052.753153639598, 7069.08101946754, 7099.6450177490915, 7330.890036649348, 6934.930650693428, 7040.683169257498, 7043.647817609201, 7050.330218629222, 7064.682089305891, 8084.63619137152, 8208.138145494637, 8438.620262088343, 8520.829583408422, 8553.486790792573, 8690.608922598372, 8882.245009174292, 8882.955585222033, 8884.111588841064, 8892.911070889468, 5923.822285331447, 6336.17629708135, 6490.643014634241, 6512.869742605027, 6707.5975441473665, 7197.604131772803, 7236.96381518089, 7258.056452661121, 7273.636318184175, 7291.489595728461, 6312.390340463153, 6421.325760795236, 6481.189851268591, 6549.083128362128, 6577.868442631217, 6387.489000880011, 6410.358804384699, 6447.194100737408, 6483.189601299838, 6505.5446118773125, 6698.83252918681, 6740.056392105012, 6759.966200169164, 6818.829529261808, 6838.418734407631, 6152.384761523812, 6198.0, 6208.255009398901, 6243.37672205239, 6246.437820596168, 6385.96807015962, 6392.808215753349, 6436.0989461476365, 6443.355664433519, 6448.548601597843], "unit": "score", "name": "mootools.html", "value": 4390.477296613186}, {"lowerIsBetter": false, "replicates": [316.0802065987974, 320.6168628488956, 321.8503395920897, 326.3815070441515, 328.16645719871514, 5271.81548645797, 5368.0, 5373.086575282202, 5382.058139825534, 5383.946160538403, 5295.232191332255, 5297.417284098756, 5312.946870531303, 5319.0957537218665, 5332.813351532697, 3949.4273330367078, 4064.756114633117, 4136.917261654765, 4143.274926887798, 4163.708540402173, 4184.100418410041, 4186.413902053715, 4187.078842654626, 4187.518435379925, 4189.916201675965, 4132.462779838616, 4139.586041395866, 4139.7930103494855, 4143.502779666444, 4144.8134833932545, 3935.0752573145287, 4037.5356833964174, 4038.8788336349958, 4047.5547689754103, 4151.875443736692, 3561.6438356164176, 3562.4656301554714, 3577.928441431183, 3599.5140656011367, 3608.6210947850623, 4994.101061808873, 5020.573251273646, 5039.596832253411, 5044.780296669491, 5055.266986287004, 4729.810807567693, 4733.384659994179, 4737.597304229144, 4737.73942433166, 4751.857444276678, 5590.9592998555645, 5590.972045139748, 5608.214849921014, 5610.13042978339, 5617.943820561783, 3928.2339943710986, 3932.7640341579313, 3942.960570394288, 3943.921121577552, 3944.7830369329677, 5615.438456154393, 5840.47435730782, 5849.385814489502, 5873.089671100986, 5910.615809972338, 4079.143379890197, 4130.56629053945, 4139.81370838307, 4152.1280531088205, 4155.293600087993, 4197.874063778091, 4207.410962465257, 4212.283911734951, 4219.261629214875, 4224.302990006615, 4768.0, 4771.809127634856, 4776.5701086902345, 4778.689385189951, 4785.3300537924715, 5594.720263986866, 5610.186522954149, 5615.578831587647, 5616.354119276336, 5618.213450116987, 1464.7436698577706, 1487.226642146078, 1487.7470829958934, 1488.1368806092441, 1493.3951749541452, 966.5215718219526, 1003.3127307794184, 1004.9748756281151, 1006.7231511334295, 1039.18424037132, 4783.0, 4885.511448855086, 4909.189983652729, 4914.999999999928, 4923.950760492421, 5679.574031947621, 5765.4522820332, 5816.709164541756, 5819.4762471376935, 5823.82528524145, 4910.852674419773, 4923.261510773341, 4925.901481970341, 4947.035328111056, 4958.305837182797, 3094.3501864608684, 3128.5463607776746, 3131.091983324856, 3132.545780861762, 3134.451470992567, 5518.061929471999, 5521.033819081645, 5522.66863988162, 5530.032244357221, 5535.861603459865, 5790.855228619318, 5988.461038506555, 5994.460498555151, 5998.610090344114, 6014.1580178775, 5524.281843360337, 5539.8892022158525, 5546.140348246028, 5553.972230138905, 5556.333240011225, 5767.509761670305, 5833.67914764692, 5849.415058494286, 5859.94140058594, 5861.912071318849, 5710.086386178192, 5711.086226203787, 5713.143028545752, 5725.541956643375, 5727.799527016535, 5525.281713377235, 5533.391326953952, 5533.612647114664, 5541.418151094077, 5543.0, 3925.3523168676847, 3981.964689180776, 3995.1610161866333, 4021.8793436195792, 4031.2945234584417, 5810.360860305278, 5842.970785146047, 5843.970780146242, 5846.970765146147, 5849.444302791228, 5636.915446268227, 5637.605367624227, 5642.520385767256, 5651.208830763614, 5652.971735141298, 5588.3573389060775, 5609.887802244014, 5614.747336369955, 5639.154126881001, 5653.547716182778, 5498.477644623755, 5500.972495137498, 5549.833504994856, 5559.694216818114, 5561.916571251353, 5458.8908221834545, 5663.716814159358, 5664.971675141763, 5682.801101961411, 5683.943160568507, 5540.113581826889, 5554.111342185231, 5559.082751345983, 5563.944360556343, 5566.192902029264], "unit": "score", "name": "prototype.html", "value": 4237.760875523803}, {"lowerIsBetter": false, "replicates": [649.3182158733332, 723.0528008309116, 739.7078154129119, 744.9590272535011, 777.1994845309326, 11803.822942655866, 11968.34174120423, 13277.0, 13437.32813359333, 13516.729665406687, 13342.799858002138, 13408.994325425609, 13423.060385773, 13465.730685386286, 13526.594202173927, 645.4126744662358, 805.3959530352236, 811.5009269299397, 820.5568992743941, 820.63481750621, 817.1909809288791, 820.5979070255592, 821.0475848016303, 823.8599438095508, 827.9710210142646, 863.3913091270671, 871.0984131423977, 871.2246100970142, 871.2420194430822, 871.4161511787117, 674.3896773420063, 842.3513894301415, 859.5530324231396, 860.8536548786722, 862.4868203418956, 630.5145038320513, 632.7627139822566, 632.9715162817685, 633.1768700689086, 633.297040285283, 11900.107491938053, 11973.0, 12008.03935685152, 12010.819837702442, 12015.459304331325, 11454.370009649467, 11831.467583958742, 11838.704032399173, 11930.821037684442, 12100.213486123374, 9727.805443891153, 9746.658866939693, 9801.852972205423, 9935.602575896955, 9967.950160249226, 3261.8858339957987, 3311.61916379617, 3327.683870032343, 3389.8983030508875, 3395.134240768613, 44310.778446107564, 44478.77760611176, 44527.77736111331, 44735.32897006548, 45025.32462013073, 9379.484128373006, 9438.433693978383, 9439.76400589977, 9463.148316651397, 9507.714768556954, 17091.230894609525, 17144.314227430765, 17162.914185429243, 17172.22724977379, 17241.482755517354, 6004.42957918997, 6035.39646035393, 6119.959606866843, 6138.987067133873, 6141.109539116803, 3330.966690333114, 3458.844352004166, 3470.514128022079, 3484.8780292689635, 3501.1947252132154, 2635.868206589663, 2664.0675763482627, 2669.5461771498503, 2676.652035235407, 2684.530207213769, 492.2861850317055, 508.48134902399346, 509.42435048395816, 512.3007095314869, 516.2720564004735, 583.5011065538903, 608.9465225160498, 640.2573015302227, 651.563452486835, 672.7208208593477, 8046.316063134582, 8054.718084867001, 8223.712170074019, 8247.876281855777, 8278.337732981347, 642.6722371590522, 644.5842431631571, 654.9279579246279, 662.9171353580803, 663.0981864664053, 3866.74866133706, 3890.144168282973, 3909.5113110861143, 4077.3883917412627, 4111.773852438085, 52271.0, 52315.73842130765, 52367.0, 52462.73768631209, 52496.47503524916, 44736.55263447389, 44791.77604112024, 44807.32789008167, 45334.31998520025, 46062.539374606495, 40055.59944400519, 41875.0, 42096.0, 42416.1516769669, 42518.0, 8106.392020598597, 8226.62980165882, 8298.543580103153, 8313.210245026712, 8403.915960840313, 31292.843535783086, 31298.374032519678, 31969.360612788078, 32039.359212815147, 32265.193370165933, 38029.61970380371, 39648.0, 39670.0, 39825.40261896016, 40406.595934041456, 11467.942660286646, 11507.827382589101, 11529.884701152881, 11653.825192622287, 11857.16999810005, 11805.940970295094, 11825.940870295593, 12044.578439754567, 12167.695807604881, 12449.0, 10812.45937703096, 11065.170112241452, 11078.446077696244, 11341.603043893425, 11768.35274059935, 11020.944895275472, 11098.0, 11312.886871131512, 11612.361320127475, 11881.524739010343, 10964.451777411257, 10967.616133435291, 11135.83296250573, 11197.272177308449, 11237.101031917264, 9451.574679139318, 9635.5663995119, 9871.901280987386, 10013.0, 10093.899061009295, 8716.956415217883, 8747.212750852454, 8752.21230089295, 8992.685256016008, 9142.771430714285], "unit": "score", "name": "yui.html", "value": 5963.723600081228}], "name": "dromaeo_css", "value": 6361.795714001692}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 106.0, 110.0, 112.0, 111.0, 100.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [172.0, 131.0, 157.0, 168.0, 140.0, 156.0, 160.0, 136.0, 185.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 159.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 96.0, 99.0, 74.0, 74.0, 72.0, 99.0, 96.0, 75.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 141.0, 95.0, 95.0, 94.0, 140.0, 95.0, 94.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 145.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 64.0, 66.0, 64.0, 64.0, 74.0, 62.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 64.9}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 83.0, 90.0, 82.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 115.0, 116.0, 114.0, 116.0, 114.0, 132.0, 116.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [148.0, 144.0, 138.0, 138.0, 139.0, 133.0, 150.0, 140.0, 140.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 67.0, 68.0, 68.0, 70.0, 72.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1515.8}]} 09:27:56 INFO - Return code: 0 09:27:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:27:56 ERROR - # TBPL SUCCESS # 09:27:56 INFO - Running post-action listener: _resource_record_post_action 09:27:56 INFO - Running post-run listener: _resource_record_post_run 09:27:57 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 395378688; Read time: 188; Write time: 279832 09:27:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109789184; Read time: 0; Write time: 73192 09:27:57 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285589504; Read time: 188; Write time: 206640 09:27:57 INFO - Running post-run listener: _upload_blobber_files 09:27:57 INFO - Blob upload gear active. 09:27:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:57 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 09:27:57 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'] 09:27:57 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 09:27:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:27:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:58 INFO - (blobuploader) - INFO - Done attempting. 09:27:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:27:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:59 INFO - (blobuploader) - INFO - Done attempting. 09:27:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:59 INFO - Return code: 0 09:27:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc76ca4fc32cbd0497412f362904d6bb8ceb75db3ae77745ceee4d798a89f199a3e0e2c6efcb13765d309cbb4c409c7a7d4a5a057735d4be529d21a0c93842e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12ccfeebc81de3e4734b611ef6c57a22acbd3c638a46ced6eeddfe8a76b5990d21d64ff5f124e0b55078344d54c9fba39128f58c3c86e7e5dc959864e86c2257"} 09:27:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:59 INFO - Contents: 09:27:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc76ca4fc32cbd0497412f362904d6bb8ceb75db3ae77745ceee4d798a89f199a3e0e2c6efcb13765d309cbb4c409c7a7d4a5a057735d4be529d21a0c93842e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12ccfeebc81de3e4734b611ef6c57a22acbd3c638a46ced6eeddfe8a76b5990d21d64ff5f124e0b55078344d54c9fba39128f58c3c86e7e5dc959864e86c2257"} 09:27:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:59 INFO - Copying logs to upload dir... 09:27:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.718776 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-01 09:27:59.855694) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 09:27:59.859650) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 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/afc76ca4fc32cbd0497412f362904d6bb8ceb75db3ae77745ceee4d798a89f199a3e0e2c6efcb13765d309cbb4c409c7a7d4a5a057735d4be529d21a0c93842e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12ccfeebc81de3e4734b611ef6c57a22acbd3c638a46ced6eeddfe8a76b5990d21d64ff5f124e0b55078344d54c9fba39128f58c3c86e7e5dc959864e86c2257"} build_url:https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/Cpg7eVWzSjquVzasrpyoCQ/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/afc76ca4fc32cbd0497412f362904d6bb8ceb75db3ae77745ceee4d798a89f199a3e0e2c6efcb13765d309cbb4c409c7a7d4a5a057735d4be529d21a0c93842e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12ccfeebc81de3e4734b611ef6c57a22acbd3c638a46ced6eeddfe8a76b5990d21d64ff5f124e0b55078344d54c9fba39128f58c3c86e7e5dc959864e86c2257"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 09:27:59.884712) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:27:59.885034) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459526542.109193-658818616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:27:59.969115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 09:27:59.969441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 09:27:59.969786) ========= ========= Total master_lag: 0.29 =========