builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1460015296.17 results: success (0) buildid: 20160406233256 builduid: c7a37d6b4756493ba56e864756d168cf revision: 8869bc8db653c958ff631f6b1ed9fcfffd01fbb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.165482) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.165904) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.166215) ========= 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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006249 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.209476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.209777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.286907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.287170) ========= 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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.341947) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.342246) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.342607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.342893) ========= 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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 00:48: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-07 00:48:17 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.439723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.800103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.800557) ========= 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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.851076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:16.851449) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8869bc8db653c958ff631f6b1ed9fcfffd01fbb1 --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 8869bc8db653c958ff631f6b1ed9fcfffd01fbb1 --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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 00:48:17,166 truncating revision to first 12 chars 2016-04-07 00:48:17,166 Setting DEBUG logging. 2016-04-07 00:48:17,166 attempt 1/10 2016-04-07 00:48:17,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8869bc8db653?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 00:48:17,416 unpacking tar archive at: fx-team-8869bc8db653/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:17.397160) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:17.397705) ========= echo 8869bc8db653c958ff631f6b1ed9fcfffd01fbb1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8869bc8db653c958ff631f6b1ed9fcfffd01fbb1'] 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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8869bc8db653c958ff631f6b1ed9fcfffd01fbb1 program finished with exit code 0 elapsedTime=0.004675 script_repo_revision: '8869bc8db653c958ff631f6b1ed9fcfffd01fbb1' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:17.482872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:17.483179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 00:48:17.493341) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-07 00:48:17.493624) ========= /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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:48:17 INFO - MultiFileLogger online at 20160407 00:48:17 in /builds/slave/test 00:48:17 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 00:48:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:48:17 INFO - {'append_to_log': False, 00:48:17 INFO - 'base_work_dir': '/builds/slave/test', 00:48:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:48:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:48:17 INFO - 'branch': 'Fx-Team-Non-PGO', 00:48:17 INFO - 'buildbot_json_path': 'buildprops.json', 00:48:17 INFO - 'config_files': ('talos/linux_config.py',), 00:48:17 INFO - 'default_actions': ('clobber', 00:48:17 INFO - 'read-buildbot-config', 00:48:17 INFO - 'download-and-extract', 00:48:17 INFO - 'populate-webroot', 00:48:17 INFO - 'create-virtualenv', 00:48:17 INFO - 'install', 00:48:17 INFO - 'run-tests'), 00:48:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:48:17 INFO - 'download_minidump_stackwalk': True, 00:48:17 INFO - 'download_symbols': 'ondemand', 00:48:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:48:17 INFO - 'tooltool.py': '/tools/tooltool.py', 00:48:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:48:17 INFO - '/tools/misc-python/virtualenv.py')}, 00:48:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:48:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:48:17 INFO - 'installer_path': 'installer.exe', 00:48:17 INFO - 'log_level': 'info', 00:48:17 INFO - 'log_name': 'talos', 00:48:17 INFO - 'log_to_console': True, 00:48:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:48:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:48:17 INFO - 'opt_config_files': (), 00:48:17 INFO - 'pip_index': False, 00:48:17 INFO - 'sps_profile': False, 00:48:17 INFO - 'sps_profile_interval': 0, 00:48:17 INFO - 'suite': 'dromaeojs', 00:48:17 INFO - 'system_bits': '32', 00:48:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:48:17 INFO - 'title': 'talos-linux64-ix-025', 00:48:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:48:17 INFO - 'use_talos_json': True, 00:48:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:48:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:48:17 INFO - 'work_dir': 'build'} 00:48:17 INFO - ##### 00:48:17 INFO - ##### Running clobber step. 00:48:17 INFO - ##### 00:48:17 INFO - Running pre-action listener: _resource_record_pre_action 00:48:17 INFO - Running main action method: clobber 00:48:17 INFO - rmtree: /builds/slave/test/build 00:48:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:48:18 INFO - Running post-action listener: _resource_record_post_action 00:48:18 INFO - ##### 00:48:18 INFO - ##### Running read-buildbot-config step. 00:48:18 INFO - ##### 00:48:18 INFO - Running pre-action listener: _resource_record_pre_action 00:48:18 INFO - Running main action method: read_buildbot_config 00:48:18 INFO - Using buildbot properties: 00:48:18 INFO - { 00:48:18 INFO - "project": "", 00:48:18 INFO - "product": "firefox", 00:48:18 INFO - "script_repo_revision": "production", 00:48:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:48:18 INFO - "repository": "", 00:48:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:48:18 INFO - "buildid": "20160406233256", 00:48:18 INFO - "pgo_build": "False", 00:48:18 INFO - "basedir": "/builds/slave/test", 00:48:18 INFO - "buildnumber": 1619, 00:48:18 INFO - "slavename": "talos-linux64-ix-025", 00:48:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:48:18 INFO - "platform": "ubuntu64_hw", 00:48:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:48:18 INFO - "branch": "fx-team", 00:48:18 INFO - "repo_path": "integration/fx-team", 00:48:18 INFO - "revision": "8869bc8db653c958ff631f6b1ed9fcfffd01fbb1", 00:48:18 INFO - "stage_platform": "linux64", 00:48:18 INFO - "builduid": "c7a37d6b4756493ba56e864756d168cf", 00:48:18 INFO - "slavebuilddir": "test" 00:48:18 INFO - } 00:48:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 00:48:18 INFO - Running post-action listener: _resource_record_post_action 00:48:18 INFO - ##### 00:48:18 INFO - ##### Running download-and-extract step. 00:48:18 INFO - ##### 00:48:18 INFO - Running pre-action listener: _resource_record_pre_action 00:48:18 INFO - Running main action method: download_and_extract 00:48:18 INFO - mkdir: /builds/slave/test/build/tests 00:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:18 INFO - https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:48:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:48:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:48:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:23 INFO - Downloaded 1361 bytes. 00:48:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:48:23 INFO - Using the following test package requirements: 00:48:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:48:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:48:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:23 INFO - u'jsshell-linux-x86_64.zip'], 00:48:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:48:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:48:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:48:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:48:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:48:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:23 INFO - https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:48:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:48:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:24 INFO - Downloaded 22136277 bytes. 00:48:24 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'] 00:48:24 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 00:48:25 INFO - Return code: 0 00:48:25 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 00:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:25 INFO - https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:48:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:48:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:26 INFO - Downloaded 22136277 bytes. 00:48:26 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'] 00:48:26 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 00:48:28 INFO - Return code: 0 00:48:28 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')]} 00:48:28 INFO - https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:48:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:29 INFO - Downloaded 10847617 bytes. 00:48:29 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'] 00:48:29 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 00:48:30 INFO - Return code: 0 00:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:30 INFO - https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EowXDSeHSVyMfX2rLsMKrw/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 00:48:31 INFO - Downloaded 54193151 bytes. 00:48:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:48:31 INFO - mkdir: /builds/slave/test/properties 00:48:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:48:31 INFO - Writing to file /builds/slave/test/properties/build_url 00:48:31 INFO - Contents: 00:48:31 INFO - build_url:https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:48:32 INFO - Running post-action listener: _resource_record_post_action 00:48:32 INFO - Running post-action listener: set_extra_try_arguments 00:48:32 INFO - ##### 00:48:32 INFO - ##### Running populate-webroot step. 00:48:32 INFO - ##### 00:48:32 INFO - Running pre-action listener: _resource_record_pre_action 00:48:32 INFO - Running main action method: populate_webroot 00:48:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:48:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:48:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:48:32 INFO - '--tppagecycles', 00:48:32 INFO - '7'], 00:48:32 INFO - 'tests': ['tsvgm']}}, 00:48:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:48:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:48:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:48:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:48:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:32 INFO - 'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:32 INFO - 'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['damp', 'tps']}, 00:48:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:32 INFO - 'tests': ['damp', 'tps']}, 00:48:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['dromaeo_dom']}, 00:48:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:48:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['a11yr', 00:48:32 INFO - 'ts_paint', 00:48:32 INFO - 'tpaint', 00:48:32 INFO - 'sessionrestore', 00:48:32 INFO - 'sessionrestore_no_auto_restore', 00:48:32 INFO - 'tabpaint']}, 00:48:32 INFO - 'other-e10s': {'tests': ['a11yr', 00:48:32 INFO - 'ts_paint', 00:48:32 INFO - 'tpaint', 00:48:32 INFO - 'sessionrestore', 00:48:32 INFO - 'sessionrestore_no_auto_restore', 00:48:32 INFO - 'tabpaint']}, 00:48:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:48:32 INFO - 'ts_paint', 00:48:32 INFO - 'tpaint', 00:48:32 INFO - 'sessionrestore', 00:48:32 INFO - 'sessionrestore_no_auto_restore', 00:48:32 INFO - 'tabpaint']}, 00:48:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:48:32 INFO - 'ts_paint', 00:48:32 INFO - 'tpaint', 00:48:32 INFO - 'sessionrestore', 00:48:32 INFO - 'sessionrestore_no_auto_restore', 00:48:32 INFO - 'tabpaint']}, 00:48:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['a11yr', 00:48:32 INFO - 'ts_paint', 00:48:32 INFO - 'tpaint', 00:48:32 INFO - 'sessionrestore', 00:48:32 INFO - 'sessionrestore_no_auto_restore', 00:48:32 INFO - 'tabpaint']}, 00:48:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['a11yr', 00:48:32 INFO - 'ts_paint', 00:48:32 INFO - 'tpaint', 00:48:32 INFO - 'sessionrestore', 00:48:32 INFO - 'sessionrestore_no_auto_restore', 00:48:32 INFO - 'tabpaint']}, 00:48:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['tsvgx', 00:48:32 INFO - 'tsvgr_opacity', 00:48:32 INFO - 'tart', 00:48:32 INFO - 'tscrollx', 00:48:32 INFO - 'cart']}, 00:48:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:48:32 INFO - 'tsvgr_opacity', 00:48:32 INFO - 'tart', 00:48:32 INFO - 'tscrollx', 00:48:32 INFO - 'cart']}, 00:48:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:32 INFO - 'talos_options': ['--disable-e10s'], 00:48:32 INFO - 'tests': ['tp5o']}, 00:48:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:32 INFO - 'tests': ['tp5o']}, 00:48:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:32 INFO - 'talos_options': ['--disable-e10s', 00:48:32 INFO - '--xperf_path', 00:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:32 INFO - 'tests': ['tp5n']}, 00:48:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:32 INFO - 'talos_options': ['--xperf_path', 00:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:32 INFO - 'tests': ['tp5n']}}, 00:48:32 INFO - 'talos.zip': {'path': '', 00:48:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:48:32 INFO - Running post-action listener: _resource_record_post_action 00:48:32 INFO - ##### 00:48:32 INFO - ##### Running create-virtualenv step. 00:48:32 INFO - ##### 00:48:32 INFO - Running pre-action listener: _resource_record_pre_action 00:48:32 INFO - Running main action method: create_virtualenv 00:48:32 INFO - Creating virtualenv /builds/slave/test/build/venv 00:48: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 00:48:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:48:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:48:32 INFO - Using real prefix '/usr' 00:48:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:48:33 INFO - Installing distribute.............................................................................................................................................................................................done. 00:48:35 INFO - Installing pip.................done. 00:48:35 INFO - Return code: 0 00:48:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:48: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')]} 00:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48: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', 'pip>=1.5'] in /builds/slave/test/build 00:48: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 pip>=1.5 00:48:35 INFO - Using env: {'DISPLAY': ':0', 00:48:35 INFO - 'HOME': '/home/cltbld', 00:48:35 INFO - 'LANG': 'en_US.UTF-8', 00:48:35 INFO - 'LANGUAGE': 'en_US:en', 00:48:35 INFO - 'LOGNAME': 'cltbld', 00:48:35 INFO - 'MAIL': '/var/mail/cltbld', 00:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:35 INFO - 'MOZ_NO_REMOTE': '1', 00:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:35 INFO - 'NO_EM_RESTART': '1', 00:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:35 INFO - 'PWD': '/builds/slave/test', 00:48:35 INFO - 'SHELL': '/bin/bash', 00:48:35 INFO - 'SHLVL': '1', 00:48:35 INFO - 'TERM': 'linux', 00:48:35 INFO - 'TMOUT': '86400', 00:48:35 INFO - 'USER': 'cltbld', 00:48:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:35 INFO - '_': '/tools/buildbot/bin/python'} 00:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48: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 00:48:35 INFO - Cleaning up... 00:48:35 INFO - Return code: 0 00:48:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:48: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')]} 00:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48: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 00:48: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 00:48:35 INFO - Using env: {'DISPLAY': ':0', 00:48:35 INFO - 'HOME': '/home/cltbld', 00:48:35 INFO - 'LANG': 'en_US.UTF-8', 00:48:35 INFO - 'LANGUAGE': 'en_US:en', 00:48:35 INFO - 'LOGNAME': 'cltbld', 00:48:35 INFO - 'MAIL': '/var/mail/cltbld', 00:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:35 INFO - 'MOZ_NO_REMOTE': '1', 00:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:35 INFO - 'NO_EM_RESTART': '1', 00:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:35 INFO - 'PWD': '/builds/slave/test', 00:48:35 INFO - 'SHELL': '/bin/bash', 00:48:35 INFO - 'SHLVL': '1', 00:48:35 INFO - 'TERM': 'linux', 00:48:35 INFO - 'TMOUT': '86400', 00:48:35 INFO - 'USER': 'cltbld', 00:48:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:35 INFO - '_': '/tools/buildbot/bin/python'} 00:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:35 INFO - Downloading/unpacking psutil>=0.7.1 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:48:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:37 INFO - Installing collected packages: psutil 00:48:37 INFO - Running setup.py install for psutil 00:48:37 INFO - building 'psutil._psutil_linux' extension 00:48:37 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 00:48:37 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 00:48:37 INFO - building 'psutil._psutil_posix' extension 00:48:37 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 00:48:37 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 00:48:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:38 INFO - Successfully installed psutil 00:48:38 INFO - Cleaning up... 00:48:39 INFO - Return code: 0 00:48:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:39 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 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48:39 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 00:48:39 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 00:48:39 INFO - Using env: {'DISPLAY': ':0', 00:48:39 INFO - 'HOME': '/home/cltbld', 00:48:39 INFO - 'LANG': 'en_US.UTF-8', 00:48:39 INFO - 'LANGUAGE': 'en_US:en', 00:48:39 INFO - 'LOGNAME': 'cltbld', 00:48:39 INFO - 'MAIL': '/var/mail/cltbld', 00:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:39 INFO - 'MOZ_NO_REMOTE': '1', 00:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:39 INFO - 'NO_EM_RESTART': '1', 00:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:39 INFO - 'PWD': '/builds/slave/test', 00:48:39 INFO - 'SHELL': '/bin/bash', 00:48:39 INFO - 'SHLVL': '1', 00:48:39 INFO - 'TERM': 'linux', 00:48:39 INFO - 'TMOUT': '86400', 00:48:39 INFO - 'USER': 'cltbld', 00:48:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:39 INFO - '_': '/tools/buildbot/bin/python'} 00:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:48: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) 00:48:41 INFO - Installing collected packages: mozsystemmonitor 00:48:41 INFO - Running setup.py install for mozsystemmonitor 00:48:41 INFO - Successfully installed mozsystemmonitor 00:48:41 INFO - Cleaning up... 00:48:41 INFO - Return code: 0 00:48:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:48: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')]} 00:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48: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 00:48: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 00:48:41 INFO - Using env: {'DISPLAY': ':0', 00:48:41 INFO - 'HOME': '/home/cltbld', 00:48:41 INFO - 'LANG': 'en_US.UTF-8', 00:48:41 INFO - 'LANGUAGE': 'en_US:en', 00:48:41 INFO - 'LOGNAME': 'cltbld', 00:48:41 INFO - 'MAIL': '/var/mail/cltbld', 00:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:41 INFO - 'MOZ_NO_REMOTE': '1', 00:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:41 INFO - 'NO_EM_RESTART': '1', 00:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:41 INFO - 'PWD': '/builds/slave/test', 00:48:41 INFO - 'SHELL': '/bin/bash', 00:48:41 INFO - 'SHLVL': '1', 00:48:41 INFO - 'TERM': 'linux', 00:48:41 INFO - 'TMOUT': '86400', 00:48:41 INFO - 'USER': 'cltbld', 00:48:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:41 INFO - '_': '/tools/buildbot/bin/python'} 00:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:41 INFO - Downloading/unpacking blobuploader==1.2.4 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:43 INFO - Downloading blobuploader-1.2.4.tar.gz 00:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:48:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:48:43 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 00:48:43 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 00:48:43 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 00:48:43 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 00:48:43 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 00:48:43 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 00:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:48:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:44 INFO - Downloading docopt-0.6.1.tar.gz 00:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:48:44 INFO - Installing collected packages: blobuploader, requests, docopt 00:48:44 INFO - Running setup.py install for blobuploader 00:48:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:48:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:48:44 INFO - Running setup.py install for requests 00:48:44 INFO - Running setup.py install for docopt 00:48:45 INFO - Successfully installed blobuploader requests docopt 00:48:45 INFO - Cleaning up... 00:48:45 INFO - Return code: 0 00:48:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48: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')]} 00:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48: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 00:48: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 00:48:45 INFO - Using env: {'DISPLAY': ':0', 00:48:45 INFO - 'HOME': '/home/cltbld', 00:48:45 INFO - 'LANG': 'en_US.UTF-8', 00:48:45 INFO - 'LANGUAGE': 'en_US:en', 00:48:45 INFO - 'LOGNAME': 'cltbld', 00:48:45 INFO - 'MAIL': '/var/mail/cltbld', 00:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:45 INFO - 'MOZ_NO_REMOTE': '1', 00:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:45 INFO - 'NO_EM_RESTART': '1', 00:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:45 INFO - 'PWD': '/builds/slave/test', 00:48:45 INFO - 'SHELL': '/bin/bash', 00:48:45 INFO - 'SHLVL': '1', 00:48:45 INFO - 'TERM': 'linux', 00:48:45 INFO - 'TMOUT': '86400', 00:48:45 INFO - 'USER': 'cltbld', 00:48:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:45 INFO - '_': '/tools/buildbot/bin/python'} 00:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:48:45 INFO - Running setup.py (path:/tmp/pip-rEgPyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:48:45 INFO - Running setup.py (path:/tmp/pip-Bq83FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:48:45 INFO - Running setup.py (path:/tmp/pip-9yt910-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:48:45 INFO - Running setup.py (path:/tmp/pip-Dckkk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:48:45 INFO - Running setup.py (path:/tmp/pip-cjy_C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:48:45 INFO - Running setup.py (path:/tmp/pip-YWhmYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:48:45 INFO - Running setup.py (path:/tmp/pip-vDxHxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:48:45 INFO - Running setup.py (path:/tmp/pip-JjGt9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:48:45 INFO - Running setup.py (path:/tmp/pip-tQivtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:48:45 INFO - Running setup.py (path:/tmp/pip-v2i17F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:48:46 INFO - Running setup.py (path:/tmp/pip-791taF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:48:46 INFO - Running setup.py (path:/tmp/pip-QqC216-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:48:46 INFO - Running setup.py (path:/tmp/pip-V0Qxe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:48:46 INFO - Running setup.py (path:/tmp/pip-QoJADe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:46 INFO - Running setup.py (path:/tmp/pip-MAuu3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:48:46 INFO - Running setup.py (path:/tmp/pip-p1MXwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:48:46 INFO - Running setup.py (path:/tmp/pip-mmQZNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:48:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:48:46 INFO - Running setup.py install for manifestparser 00:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:48:46 INFO - Running setup.py install for mozcrash 00:48:46 INFO - Running setup.py install for mozdebug 00:48:46 INFO - Running setup.py install for mozdevice 00:48:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:48:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Running setup.py install for mozfile 00:48:47 INFO - Running setup.py install for mozhttpd 00:48:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Running setup.py install for mozinfo 00:48:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Running setup.py install for mozInstall 00:48:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Running setup.py install for mozleak 00:48:47 INFO - Running setup.py install for mozlog 00:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Running setup.py install for moznetwork 00:48:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Running setup.py install for mozprocess 00:48:47 INFO - Running setup.py install for mozprofile 00:48:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:48:47 INFO - Running setup.py install for mozrunner 00:48:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:48:48 INFO - Running setup.py install for mozscreenshot 00:48:48 INFO - Running setup.py install for moztest 00:48:48 INFO - Running setup.py install for mozversion 00:48:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:48:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:48:48 INFO - Cleaning up... 00:48:48 INFO - Return code: 0 00:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:48 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 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48:48 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 00:48:48 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 00:48:48 INFO - Using env: {'DISPLAY': ':0', 00:48:48 INFO - 'HOME': '/home/cltbld', 00:48:48 INFO - 'LANG': 'en_US.UTF-8', 00:48:48 INFO - 'LANGUAGE': 'en_US:en', 00:48:48 INFO - 'LOGNAME': 'cltbld', 00:48:48 INFO - 'MAIL': '/var/mail/cltbld', 00:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:48 INFO - 'MOZ_NO_REMOTE': '1', 00:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:48 INFO - 'NO_EM_RESTART': '1', 00:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:48 INFO - 'PWD': '/builds/slave/test', 00:48:48 INFO - 'SHELL': '/bin/bash', 00:48:48 INFO - 'SHLVL': '1', 00:48:48 INFO - 'TERM': 'linux', 00:48:48 INFO - 'TMOUT': '86400', 00:48:48 INFO - 'USER': 'cltbld', 00:48:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:48 INFO - '_': '/tools/buildbot/bin/python'} 00:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:48:48 INFO - Running setup.py (path:/tmp/pip-A8XQnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:48:48 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)) 00:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:48:48 INFO - Running setup.py (path:/tmp/pip-tMvnwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:48:48 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)) 00:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:48:48 INFO - Running setup.py (path:/tmp/pip-rhVdNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:48:48 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)) 00:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:48:48 INFO - Running setup.py (path:/tmp/pip-PgRYJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:48:48 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)) 00:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:48:48 INFO - Running setup.py (path:/tmp/pip-161hAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:48:48 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)) 00:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:48:48 INFO - Running setup.py (path:/tmp/pip-o4ZnRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:48: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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:48:49 INFO - Running setup.py (path:/tmp/pip-Iu0syB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:48: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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:48:49 INFO - Running setup.py (path:/tmp/pip-WWLCHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:48: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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:48:49 INFO - Running setup.py (path:/tmp/pip-LNLt3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:48: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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:48:49 INFO - Running setup.py (path:/tmp/pip-7J9kwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:48:49 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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:48:49 INFO - Running setup.py (path:/tmp/pip-tgTCkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:48:49 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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:48:49 INFO - Running setup.py (path:/tmp/pip-7XJft5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:48:49 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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:48:49 INFO - Running setup.py (path:/tmp/pip-4gyESR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:48:49 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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:48:49 INFO - Running setup.py (path:/tmp/pip-qKafKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:48:49 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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:49 INFO - Running setup.py (path:/tmp/pip-mADySf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:49 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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:48:49 INFO - Running setup.py (path:/tmp/pip-PpUBdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:48:49 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)) 00:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:48:49 INFO - Running setup.py (path:/tmp/pip-jNPkq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:48:49 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)) 00:48:49 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)) 00:48:49 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)) 00:48:49 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)) 00:48:49 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)) 00:48:49 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)) 00:48:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:48:49 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 00:48:49 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 00:48:49 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 00:48:49 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 00:48:49 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 00:48:49 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 00:48:51 INFO - Downloading blessings-1.6.tar.gz 00:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:48:51 INFO - Installing collected packages: blessings 00:48:51 INFO - Running setup.py install for blessings 00:48:51 INFO - Successfully installed blessings 00:48:51 INFO - Cleaning up... 00:48:51 INFO - Return code: 0 00:48:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:48:52 INFO - Reading from file tmpfile_stdout 00:48:52 INFO - Current package versions: 00:48:52 INFO - argparse == 1.2.1 00:48:52 INFO - blessings == 1.6 00:48:52 INFO - blobuploader == 1.2.4 00:48:52 INFO - docopt == 0.6.1 00:48:52 INFO - manifestparser == 1.1 00:48:52 INFO - mozInstall == 1.12 00:48:52 INFO - mozcrash == 0.17 00:48:52 INFO - mozdebug == 0.1 00:48:52 INFO - mozdevice == 0.48 00:48:52 INFO - mozfile == 1.2 00:48:52 INFO - mozhttpd == 0.7 00:48:52 INFO - mozinfo == 0.9 00:48:52 INFO - mozleak == 0.1 00:48:52 INFO - mozlog == 3.1 00:48:52 INFO - moznetwork == 0.27 00:48:52 INFO - mozprocess == 0.22 00:48:52 INFO - mozprofile == 0.28 00:48:52 INFO - mozrunner == 6.11 00:48:52 INFO - mozscreenshot == 0.1 00:48:52 INFO - mozsystemmonitor == 0.0 00:48:52 INFO - moztest == 0.7 00:48:52 INFO - mozversion == 1.4 00:48:52 INFO - psutil == 3.1.1 00:48:52 INFO - requests == 1.2.3 00:48:52 INFO - wsgiref == 0.1.2 00:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:52 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 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48:52 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 00:48:52 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 00:48:52 INFO - Using env: {'DISPLAY': ':0', 00:48:52 INFO - 'HOME': '/home/cltbld', 00:48:52 INFO - 'LANG': 'en_US.UTF-8', 00:48:52 INFO - 'LANGUAGE': 'en_US:en', 00:48:52 INFO - 'LOGNAME': 'cltbld', 00:48:52 INFO - 'MAIL': '/var/mail/cltbld', 00:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:52 INFO - 'MOZ_NO_REMOTE': '1', 00:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:52 INFO - 'NO_EM_RESTART': '1', 00:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:52 INFO - 'PWD': '/builds/slave/test', 00:48:52 INFO - 'SHELL': '/bin/bash', 00:48:52 INFO - 'SHLVL': '1', 00:48:52 INFO - 'TERM': 'linux', 00:48:52 INFO - 'TMOUT': '86400', 00:48:52 INFO - 'USER': 'cltbld', 00:48:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:52 INFO - '_': '/tools/buildbot/bin/python'} 00:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 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)) 00:48:52 INFO - Cleaning up... 00:48:52 INFO - Return code: 0 00:48:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:52 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 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48:52 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 00:48:52 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 00:48:52 INFO - Using env: {'DISPLAY': ':0', 00:48:52 INFO - 'HOME': '/home/cltbld', 00:48:52 INFO - 'LANG': 'en_US.UTF-8', 00:48:52 INFO - 'LANGUAGE': 'en_US:en', 00:48:52 INFO - 'LOGNAME': 'cltbld', 00:48:52 INFO - 'MAIL': '/var/mail/cltbld', 00:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:52 INFO - 'MOZ_NO_REMOTE': '1', 00:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:52 INFO - 'NO_EM_RESTART': '1', 00:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:52 INFO - 'PWD': '/builds/slave/test', 00:48:52 INFO - 'SHELL': '/bin/bash', 00:48:52 INFO - 'SHLVL': '1', 00:48:52 INFO - 'TERM': 'linux', 00:48:52 INFO - 'TMOUT': '86400', 00:48:52 INFO - 'USER': 'cltbld', 00:48:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:52 INFO - '_': '/tools/buildbot/bin/python'} 00:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:52 INFO - Downloading/unpacking jsonschema 00:48:52 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 00:48:52 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 00:48:52 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 00:48:52 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 00:48:52 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 00:48:52 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 00:48:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:48:54 INFO - Downloading/unpacking functools32 (from jsonschema) 00:48:54 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 00:48:54 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 00:48:54 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 00:48:54 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 00:48:54 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 00:48:54 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 00:48:54 INFO - Downloading functools32-3.2.3-2.tar.gz 00:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:48:54 INFO - warning: no files found matching '*.txt' 00:48:54 INFO - no previously-included directories found matching 'build' 00:48:54 INFO - no previously-included directories found matching 'dist' 00:48:54 INFO - no previously-included directories found matching '.git*' 00:48:54 INFO - Installing collected packages: jsonschema, functools32 00:48:54 INFO - Running setup.py install for functools32 00:48:54 INFO - warning: no files found matching '*.txt' 00:48:54 INFO - no previously-included directories found matching 'build' 00:48:54 INFO - no previously-included directories found matching 'dist' 00:48:54 INFO - no previously-included directories found matching '.git*' 00:48:54 INFO - Successfully installed jsonschema functools32 00:48:54 INFO - Cleaning up... 00:48:54 INFO - Return code: 0 00:48:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:54 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 0x7fe7095d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15615a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, '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': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', '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 00:48:54 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 00:48:54 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 00:48:54 INFO - Using env: {'DISPLAY': ':0', 00:48:54 INFO - 'HOME': '/home/cltbld', 00:48:54 INFO - 'LANG': 'en_US.UTF-8', 00:48:54 INFO - 'LANGUAGE': 'en_US:en', 00:48:54 INFO - 'LOGNAME': 'cltbld', 00:48:54 INFO - 'MAIL': '/var/mail/cltbld', 00:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:54 INFO - 'MOZ_NO_REMOTE': '1', 00:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:54 INFO - 'NO_EM_RESTART': '1', 00:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:54 INFO - 'PWD': '/builds/slave/test', 00:48:54 INFO - 'SHELL': '/bin/bash', 00:48:54 INFO - 'SHLVL': '1', 00:48:54 INFO - 'TERM': 'linux', 00:48:54 INFO - 'TMOUT': '86400', 00:48:54 INFO - 'USER': 'cltbld', 00:48:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:54 INFO - '_': '/tools/buildbot/bin/python'} 00:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:55 INFO - Downloading/unpacking flake8 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:48:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:48: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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:48:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:48:57 INFO - no previously-included directories found matching 'docs/_build' 00:48:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:48:57 INFO - Running setup.py install for pep8 00:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:48:57 INFO - no previously-included directories found matching 'docs/_build' 00:48:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:48:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:48:57 INFO - Cleaning up... 00:48:57 INFO - Return code: 0 00:48:57 INFO - Running post-action listener: _resource_record_post_action 00:48:57 INFO - Running post-action listener: _start_resource_monitoring 00:48:57 INFO - Starting resource monitoring. 00:48:57 INFO - ##### 00:48:57 INFO - ##### Running install step. 00:48:57 INFO - ##### 00:48:57 INFO - Running pre-action listener: _resource_record_pre_action 00:48:57 INFO - Running main action method: install 00:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:48:58 INFO - Reading from file tmpfile_stdout 00:48:58 INFO - Detecting whether we're running mozinstall >=1.0... 00:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:48:58 INFO - Reading from file tmpfile_stdout 00:48:58 INFO - Output received: 00:48:58 INFO - Usage: mozinstall [options] installer 00:48:58 INFO - Options: 00:48:58 INFO - -h, --help show this help message and exit 00:48:58 INFO - -d DEST, --destination=DEST 00:48:58 INFO - Directory to install application into. [default: 00:48:58 INFO - "/builds/slave/test"] 00:48:58 INFO - --app=APP Application being installed. [default: firefox] 00:48:58 INFO - mkdir: /builds/slave/test/build/application 00:48:58 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'] 00:48:58 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 00:49:13 INFO - Reading from file tmpfile_stdout 00:49:13 INFO - Output received: 00:49:13 INFO - /builds/slave/test/build/application/firefox/firefox 00:49:13 INFO - Running post-action listener: _resource_record_post_action 00:49:13 INFO - ##### 00:49:13 INFO - ##### Running run-tests step. 00:49:13 INFO - ##### 00:49:13 INFO - Running pre-action listener: _resource_record_pre_action 00:49:13 INFO - Running main action method: run_tests 00:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:49:13 INFO - Python 2.7.3 00:49:13 INFO - Return code: 0 00:49:13 INFO - grabbing minidump binary from tooltool 00:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:13 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 0x15f0410>, '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 0x15f1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:49:13 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 00:49:13 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 00:49:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:49:13 INFO - Return code: 0 00:49:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:49:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:49:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:49:14 INFO - Return code: 0 00:49:14 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/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 00:49:14 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/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 00:49:14 INFO - Using env: {'DISPLAY': ':0', 00:49:14 INFO - 'HOME': '/home/cltbld', 00:49:14 INFO - 'LANG': 'en_US.UTF-8', 00:49:14 INFO - 'LANGUAGE': 'en_US:en', 00:49:14 INFO - 'LOGNAME': 'cltbld', 00:49:14 INFO - 'MAIL': '/var/mail/cltbld', 00:49:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:49:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:14 INFO - 'MOZ_NO_REMOTE': '1', 00:49:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:14 INFO - 'NO_EM_RESTART': '1', 00:49:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:14 INFO - 'PWD': '/builds/slave/test', 00:49:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:49:14 INFO - 'SHELL': '/bin/bash', 00:49:14 INFO - 'SHLVL': '1', 00:49:14 INFO - 'TERM': 'linux', 00:49:14 INFO - 'TMOUT': '86400', 00:49:14 INFO - 'USER': 'cltbld', 00:49:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616', 00:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:14 INFO - '_': '/tools/buildbot/bin/python'} 00:49:14 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/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 00:49:15 INFO - mozversion application_buildid: 20160406233256 00:49:15 INFO - mozversion application_changeset: 8869bc8db653c958ff631f6b1ed9fcfffd01fbb1 00:49:15 INFO - mozversion application_display_name: Nightly 00:49:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:49:15 INFO - mozversion application_name: Firefox 00:49:15 INFO - mozversion application_remotingname: firefox 00:49:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:49:15 INFO - mozversion application_vendor: Mozilla 00:49:15 INFO - mozversion application_version: 48.0a1 00:49:15 INFO - mozversion platform_buildid: 20160406233256 00:49:15 INFO - mozversion platform_changeset: 8869bc8db653c958ff631f6b1ed9fcfffd01fbb1 00:49:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:49:15 INFO - mozversion platform_version: 48.0a1 00:49:15 INFO - using testdate: 1460015355 00:49:15 INFO - actual date: 1460015355 00:49:15 INFO - starting webserver on 'localhost:38119' 00:49:15 INFO - SUITE-START | Running 2 tests 00:49:15 INFO - TEST-START | dromaeo_css 00:49:15 INFO - operating with platform_type : linux_ 00:49:15 INFO - Initialising browser for dromaeo_css test... 00:49:15 INFO - TEST-INFO | started process 6271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP6glfz/profile http://localhost:38119/getInfo.html) 00:49:19 INFO - PROCESS | 6271 | __metrics Screen width/height:1600/1200 00:49:19 INFO - PROCESS | 6271 | colorDepth:24 00:49:19 INFO - PROCESS | 6271 | Browser inner width/height: 1024/697 00:49:19 INFO - PROCESS | 6271 | __metrics 00:49:20 ERROR - PROCESS | 6271 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:49:21 INFO - TEST-INFO | 6271: exit 0 00:49:21 INFO - Browser initialized. 00:49:21 INFO - Running cycle 1/1 for dromaeo_css test... 00:49:21 INFO - TEST-INFO | started process 6353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP6glfz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:49:33 INFO - PROCESS | 6353 | RSS: Main: 155381760 00:49:33 INFO - PROCESS | 6353 | 00:50:24 INFO - PROCESS | 6353 | 1460015424335 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] 00:52:35 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38119/tests/dromaeo/cssquery-ext.html) 00:52:36 INFO - PROCESS | 6353 | RSS: Main: 234565632 00:52:36 INFO - PROCESS | 6353 | 00:55:39 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-ext.html (next: http://localhost:38119/tests/dromaeo/cssquery-jquery.html) 00:55:39 INFO - PROCESS | 6353 | RSS: Main: 237453312 00:55:39 INFO - PROCESS | 6353 | 00:58:41 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38119/tests/dromaeo/cssquery-mootools.html) 00:58:42 INFO - PROCESS | 6353 | RSS: Main: 233136128 00:58:42 INFO - PROCESS | 6353 | 01:01:44 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38119/tests/dromaeo/cssquery-prototype.html) 01:01:44 INFO - PROCESS | 6353 | RSS: Main: 215769088 01:01:44 INFO - PROCESS | 6353 | 01:04:47 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38119/tests/dromaeo/cssquery-yui.html) 01:04:47 INFO - PROCESS | 6353 | RSS: Main: 200105984 01:04:47 INFO - PROCESS | 6353 | 01:07:50 INFO - PROCESS | 6353 | Cycle 1(1): loaded http://localhost:38119/tests/dromaeo/cssquery-yui.html (next: http://localhost:38119/tests/dromaeo/cssquery-dojo.html) 01:07:50 INFO - PROCESS | 6353 | RSS: Main: 288567296 01:07:50 INFO - PROCESS | 6353 | 01:07:50 INFO - PROCESS | 6353 | __start_tp_report 01:07:50 INFO - PROCESS | 6353 | _x_x_mozilla_page_load 01:07:50 INFO - PROCESS | 6353 | _x_x_mozilla_page_load_details 01:07:50 INFO - PROCESS | 6353 | |i|pagename|runs| 01:07:50 INFO - PROCESS | 6353 | |0;dojo.html;2600.1939398786376;2675.8020923715203;2682.0210623122543;2691.031228757647;2713.5386984212682;4518.8418405355815;4634.675572709912;4638.860834174976;4647.907041859165;4656.441227052755;4567.474740404855;4594.58648721615;4661.324108004337;4693.483716791159;4696.600788932937;4290.056187638715;4298.269294219982;4345.3047512398025;4371.038371558252;4453.554644535553;4370.868873933787;4398.318260669601;4412.977935110336;4419.337099435078;4444.422225110731;4183.539810620845;4209.894752631178;4279.657627389833;4312.396264522969;4314.546972567867;4307.181635489247;4309.245881970643;4311.417958575615;4345.978270108661;4354.608085272309;4271.530131685512;4298.656107511423;4300.741955482681;4312.61186493214;4327.221100201962;4400.09797991411;4455.844045458393;4548.295014272793;4556.248219043854;4565.863024109282;4920.40955085392;4957.628177886637;4959.057779021974;4961.5038496150455;4965.131102057126;4964.826231081895;4967.05625931072;4984.0281145176705;4987.251912213161;5025.798968041274;4488.910221795546;4607.216773148606;4698.718076915396;4704.1062198182235;4704.623630109583;5067.341245638044;5077.111505486525;5092.719900405513;5094.61790365724;5142.820001300011;4810.494898035726;4869.683470574401;4877.219644856806;4879.194932836042;4904.583110435653;4976.825811096594;5009.223570346602;5034.672746271481;5062.316587260746;5076.974615126901;4887.73117478535;4888.633352498577;4889.804407823718;4908.141075311878;4944.480829512921;4757.976210118927;4876.975615121902;4892.877678058006;4903.828366007244;4934.309196712463;4216.409702641633;4238.470191226097;4240.660747140283;4272.273713468656;4282.464691913511;3691.409374500121;3702.740808143404;3709.9629003710156;3725.1990821972863;3740.0275928258848;4170.249355116108;4239.894002649959;4328.156009578165;4328.7402755834755;4341.6526677865695;4908.509149085135;4969.453360130383;4970.65205435616;4970.950290497121;5019.824306149268;4300.2904520754355;4301.741895486281;4301.935470967938;4307.267764480046;4342.978285108554;4267.487901451846;4466.598006179394;4479.260921947907;4495.235809912323;4542.273236282179;4709.858704238878;4710.081534100817;4713.599344055657;4734.242521196592;4739.4075740532435;4969.950300496948;4976.850694479172;4979.377577802775;4981.302617633607;5036.420811606566;4606.401167848158;4652.790624421841;4696.060787842377;4731.266653668687;4753.857384278339;4893.657443978887;4896.461389247252;4900.705957642553;4909.631777616622;4962.280469331999;4944.752762361795;4959.809645685082;4983.426905905722;4984.825531106394;5031.52200540948;4691.08523837862;4752.382190315375;4819.469858315652;4840.564349208588;4864.051509955525;4776.928346074881;4779.856604301876;4800.423949126127;4807.471178170328;4829.541193586604;4649.976750116363;4702.106599746037;4719.716816990855;4720.551547602972;4767.570918617341;4827.831025914076;4863;4881.170201065898;4899.559039686445;4924.458309586014;4679.087577922272;4728.267118596623;4728.550787675165;4730.739809310521;4781.282807578891 01:07:50 INFO - PROCESS | 6353 | |1;ext.html;532.78155956058;550.2599004339165;559.7145455817532;562.7327019665656;565.7934853778371;37541.62458375416;38008.239835203276;38046;38100.61899381005;38123;39171.21657566854;39869.202615947666;39890.40164397536;39908.201835963264;39938;7531.3221810037085;7566.772996810105;7679.6928122875015;7688.1927397623285;7832.373410127205;7658.578778167199;7799.142094369643;10026.09765121139;10335.328203666775;10355.689329320132;9935.850962235572;10043.74890627733;10048.69853904384;10049.397036177852;10050.045245701684;10174.44040577768;10270.589176432934;10272;10272.794544109076;10273.640422585248;7598.658060387296;10002.849957250646;10264.076233139054;10265.948670256601;10273.28087033908;38995.22009559793;39112.80443597792;39449.40825887614;39455;39591.40612890809;3148.2286839724416;3216.935661286761;3262.820544870031;3411.8635254589785;3646.5806432260365;29147.562786558006;29209.269768255752;29685.406291874042;29869.850650746823;30200.8489957551;3579.391503444421;3580.3929916975685;3646.6171052039685;3651.8174091295596;3763.209725957552;243800.78099609565;246123;246584;247143;247268;43258.7837060819;57344;57705.13442298369;57712.71143644255;57801;40549.79725101356;40837;40842;40845.38731919024;40855.7957210218;13372.33138343079;13459.798103028463;13474.258915759532;13488.730225395633;13493.190408575518;11709.414529273503;11860.169788114748;11862.110341724232;11879.940600296943;11891.04871610269;14714.779278310834;14773.482928097465;14804.483237849592;14846.777298340534;14860.925695371454;5541.362743284493;5744.971275143597;5826.242588463558;5841.153032810219;5878.588498805128;889.7286327670123;914.9862752058724;925.3846192282192;975.9707208783748;1055.1664185293685;26385.73614263871;27259.45481090367;27855.16434506968;28033.859830700716;28154.85922570374;1057.9894201057891;1079.3469950679726;1090.4711215060688;1104.5195340027115;1134.0983917785381;13838.238896860568;14224.715505690036;14378.784318235235;14670.266486675624;14682.339294731762;275907;587506;591316;591673;593792;48928.75535622299;49700.254496182584;50140;50246.748766255936;50290;1117.9385133817555;1193.785118678646;1245.688577855536;1278.469435184388;1289.374653293152;27059.86470067637;28684.422356770578;29226.269343265736;29633.851830740707;29749.40501189921;36012;36465.088372790895;36509.26981460409;36584.085397864204;37413.81293093517;204789;206616;206661;206686;207000;30927.69072309338;32393.51409728903;32457;32507;32526.34947301088;39540;40457.59542404538;40916.386254205616;41012.58987410088;41343.37984930168;34968.65031349756;35081.473777893865;35352.46971295381;35503.82248088743;35786.463203051455;34546.65453345434;34817.65182348144;34851.65148348484;34971;35276.647233527336;34331.4850277251;34906.825465872505;34931.47602785909;35248.82375588106;35267;29771.55342669905;31395.21511962128;31417.68582314239;31608;31667.36665266728;24421.267361979168;24646.383840403418;24647.137350192657;24929.376765581004;25028.62457063109 01:07:50 INFO - PROCESS | 6353 | |2;jquery.html;335.9630440651528;346.1553808706755;347.45796557370505;350.9596396414413;355.37099334178504;14934.551963441087;15377.538673839776;15971.920140399296;16776.161191940417;16826.495205143834;15842.049477031358;16078;17142.914285428556;17228.052457114853;17240.741388879178;4930.852074437773;5006.324146240266;5032.622553308516;5077.543021128097;5089.287499750038;4766.571008609225;4964.900701985958;4997.825076122336;4999.425066117388;5015.32293140425;4977.950220497785;4982.153033984213;4985.6260780441435;4989.376327959005;4992.525710057557;4771.570558649721;5001.949980500185;5004.349434573519;5006;5007.4491805901325;4445.73325600465;4461.486929003174;4465.040016396458;4467.6425885929375;4468.575485328888;19111.23555057796;19889.10499027547;20143.697844532344;20155.596888062304;20176.49558761028;2035.6539388303877;2088.5822835432973;2137.4763183020104;2210.823134149264;2431.732509423962;12555.121141520005;12748.80876786849;12776.87223127766;12825.422855971503;13265.734685306335;1719.604490967072;1761.1282415204555;1780.4569606270084;1787.6245988342464;1803.3057272949877;62107.378926210615;65934.34065659378;66265.66867165682;66846.33153668449;67242.3275767241;9300.39547429415;9541.2367010639;9741.805163896683;9766.414015159113;9867.40795552269;13189.670258243621;13304.733905322033;13307.401166947511;13313.600591982256;13314.134581252187;7226.494145409876;7333.266673332624;7360.374368178765;7409.073865766779;7424.443166762514;6740.898886516608;6759.357861003196;6852.177738671391;6881.552699074544;6964.373206411447;4179.101493178981;4210.7473551587;4216.47294088239;4227.013303747234;4283.057727299989;1722.5607470095297;1729.5416714570397;1756.4993976716573;1791.9283228670968;1792.6683563540787;827.2389401750404;831.339085427087;925.6019911438146;970.737900766789;976.1117383181271;16111.113888736232;16305.918470407572;16424.260908259155;16535.751963720555;16987.74518382225;853.3557164340883;862.7799911022774;869.4479005831342;880.41892351048;959.4722902403789;6729.865402692017;8816.426932249384;8921.687740929035;8929.24101451371;9035.50304733246;357491;368015;397689;406301;408220;67636;71201;71702;71725.64137179281;73044.26955730375;969.3989726369696;971.5919313888184;975.3513913247752;987.2792861211356;1000.5747557288123;13949.372278247707;14228.928855355656;14301.57095287143;14370.13779173253;14569.708605828037;29780.106596801263;30347.544786827773;30824.53763193509;31891.521627176076;32239.516407253443;46212.306815397125;46548.30177547272;46834.297485538424;47151.29273060838;47445;7389.5437955292655;7418.443616728875;7646.273604007611;7714.80420534818;7722.768316950501;9148.313876459159;11076.944615276872;11711.238769479956;11954.462049207632;12083.818742718691;9358.298127640319;10161.441120738134;10275.332103413255;10571.62999295021;10946.562137514411;9915.20678345745;10209.285350025428;10365.585376584851;10375.688729338131;10903;10146.068918376877;10868.456577170951;10916.12670986335;10929.78140437171;11091.889081109086;7390.334869861738;7550.471466997477;7600.885986710315;7741.690332386642;7988.960055199686;7936.968194134956;9387.202087822612;9868.259880509135;10159.492025398553;10281.691549253534 01:07:50 INFO - PROCESS | 6353 | |3;mootools.html;1300.2068738069781;1395.2117053864565;1405.206058576904;1558.6648870492843;1755.148752854866;6541.803745887625;6862.519623626348;6947.548409353389;6971.999999999994;6972.7908162755075;7281.089863767029;7423.962880185605;7430.962845185766;7434.182239953614;7442.8883566746545;1893.1575448925164;1930.7779605345424;1940.049375805852;2119.459537817854;2143.07847625521;2161.8919054047315;2221.9666704999436;2223.3885681437655;2223.6664500325;2225.7774222577773;2090.7595626502994;2112.9366119016377;2127.0959842067136;2131.3499382688274;2153.257126291427;2119.957600847982;2123.309924274617;2125.744910610721;2130.605837919982;2131.3073251193346;2045.2228153301799;2088.697138914849;2093.5603523259983;2103.2112957640884;2106.568153528523;7579.355754760852;7613.238676132398;7617.6572054257695;7628.504147230412;7635.961820190919;4513.0973805238755;4642.628589712815;4647.721136731807;4667.183242932473;4678.883027924295;2917.9124626261246;2996.8951086712077;3013.352129292213;3023.667396586374;3031.3634136831292;931.585444477208;953.5518306395983;965.0976337124811;967.5549247346229;988.4365911430488;10416.166706663524;10418.166546676324;10428.79142417155;10429.947850260776;10446.582136714522;4154.646855017358;4157.397177409259;4255.787210639455;4288.635465985364;4291.120320334387;8899.243564296978;8937.821243575092;8959.283257339397;8972.775680607907;8985.955070224607;4684.695494792828;4690.249560070441;4702.200625893606;4702.200625893606;4707.7881495332795;3670.6145854684873;4004.839806407711;4078;4178.91642167155;4194.559571245037;3448.534447849508;3468.3756923753463;3474.322507111089;3494.7553671243277;3528.7000604948353;1157.5948418053613;1162.8720840707515;1165.2658824940233;1168.4741866160261;1191.1602320364123;1183.331417748969;1188.3167178872184;1208.516593362662;1222.7371115210271;1237.0536539547254;7045.612491312924;7175.31834475724;7221;7223.566586004857;7299.4525410594415;413.1695292462173;428.47725774554993;448.03001501749003;448.3409388199342;448.97306161630405;5482.2873026506295;5507.504324610804;5513.255710479034;5517.668939863621;5558.777648893999;8730.476171429735;9052.81894362109;9248.075192480697;9273.72178834636;9360.765980850398;9095.590698418588;9145.176934075833;9276.397034192756;9281.582328795086;9293.210077143383;7011.228764835864;7140.5358651687475;7148.142222933177;7213.747518836815;7216.7474138404905;6772.390484856386;6813.4208592270215;6820.113385259884;6839.384455399038;6847.281035491202;7923.643436045277;8126.106128325998;8128.552929588929;8315.958420208102;8327.417080804285;8250.669973201246;8396.95801521013;8554.957225213833;8566.314694824523;8573.056963734109;6571.014347847861;6572.8356791080605;6676.298988606321;6730.562513436611;6755.054292399166;7196.208417074223;7198.20819709821;7236.565806051653;7236.638168091679;7277.017602623578;6457.903131453126;6528.347165283433;6618.106555614931;6618.172728408949;6817.931820681928;6367.3314301997625;6397.520185985976;6593.472522198117;6626.90059649096;6657.167854018247;6932.792016239319;6968.547044442095;6970.79087627372;6988.091548098715;6994.895076573754;6194.907076393948;6404.519661025535;6410.1025856381075;6420.6468644225015;6433.646149461824;6438.259600146043;6458.644774537445;6501.382368674968;6509.414152726277;6511.934880651323 01:07:50 INFO - PROCESS | 6353 | |4;prototype.html;304.9996013077108;305.85166194395725;307.6738657023555;310.58847027688313;315.9889403870865;5369.033573956686;5372.22102795095;5373.838784836456;5424.267723857278;5429.375621803494;5315.867103322419;5317.973410132953;5329.067413202683;5338.572914166867;5347.278117454142;3960.168364643414;4039.899002524931;4177.540470548237;4180.289350810354;4181.933606930229;4176.248275310443;4189.581041895816;4192.308269135589;4192.434021407102;4193;4139.234241665286;4152.522459917103;4154.231467178566;4161.292580261348;4162.937555936648;3946.1910308386855;4055.5944405559503;4155.896102597429;4179.435776170239;4187.874363769091;3672.6510981456986;3673.155174309897;3681.4661874028384;3684.3184010958057;3686.078480379905;5110.744462776846;5127.128388174019;5130.256112863651;5132.255822905695;5133.153029750087;4811.13399588074;4815.229563269895;4821.63837712173;4822.156122678517;4823.614110871122;5597.524210442118;5635.633683810539;5639.68981706006;5645.887082258373;5647.124695672136;4037.071473561068;4041.7574945503366;4044.2315959967514;4048.109415928491;4049.493813273341;5740.712964351766;5911.645301281937;5912.054071348563;5915.935131676297;5918.171455996164;4122.958770412318;4139.048018955657;4142.420061191436;4142.79286035697;4148.087420767426;4162.41726158338;4164.416981622575;4197.916041679149;4198.6011328923705;4215.768132752728;4751.3348131261655;4758.310045043519;4783.6651434399255;4793.304970779287;4797.352357431702;5611.6352437091455;5616.9608622404985;5630;5631.549476041907;5633.126865335879;1462.2396353895915;1485.9257037148316;1488.0253434000747;1488.8287846897745;1493.873020793223;937.5452905340904;985.3693636072919;987.6543209876629;995.2833959549113;998.9750256243652;4887.975560122177;4912.164931961575;4925.87685307863;4942.629302802305;4947.060058588857;5799.043157878903;5799.594028417971;5805.445603934256;5808.5933984621515;5815.88368232633;4928.704277743347;4931.506849315111;4938.901221975612;4940.950590494121;4941.481144479778;3089.088718827951;3118.4230917279924;3122.5784519090084;3124.42198193335;3128.23358277219;5453.918191227135;5455.754491047913;5464.808731694372;5466.262054622575;5472.890542189134;5773.422657734193;5940.881182376328;5942.762289508371;5944.078667806497;5945.316288626863;5390.4879036491475;5416.268803711528;5434.076207044733;5442.782288708408;5448.918266226089;5818.970905145447;5845.035569131046;5850.268716410449;5851.414858514115;5852.678102704393;5609.27079479665;5634.859128521656;5648.350439699487;5649.491545760901;5654.6889921054735;5429.5656347492895;5431.429699881455;5441.483059109379;5446.373667028342;5448.4006759257245;4059.5331536873637;4160;4170.35359519275;4171;4180.561041090763;5724.627899186539;5746.856328591819;5761.423857614205;5765.1928729977;5776.826695199151;5553.222548843246;5555;5556.694381809039;5559.16612508127;5559.9444005561045;5554.861128471821;5562.4425160955;5563.666180029211;5564;5568.359638641446;5477.822268212353;5479.0411677957;5481.971670481787;5491.560675145899;5495.807646732345;5503.11950087984;5634.774609015593;5640.435956404491;5690.601657883908;5721.370649228665;5516.724163791875;5556.027695153251;5572.498475137257;5574.052411090205;5578.581606379456 01:07:50 INFO - PROCESS | 6353 | |5;yui.html;749.056189201606;761.6191904047975;764.6864785437972;775.8603451378754;786.7364432914973;14067.718645627081;14375.065620734658;14388.784168237486;14395.64010899728;14405.20771357575;14119.858801411983;14151.575452736408;14152.150870947751;14162.29188540574;14219.075760075588;656.6880731652451;806.4475834053662;811.2090711556215;829.7552222094466;831.3930830493713;806.9354451643884;814.8288859339546;815.4332738746543;817.2440492544403;817.2685446525356;855.0167307596283;861.2894362151219;863.2144748279068;865.7229686500323;866.5060915278294;682.7678589279619;838.1032295443878;855.9443636163629;859.3941271403645;860.6901515454431;616.722474886303;618.0327787013309;618.1469571990624;618.153130211613;619.4734475695623;11847.585334513251;11878.346690931996;11884.940575297154;11912.702182445422;11936.343501107436;11850;12256.81614775779;12368.567100151451;12655.873441265561;12733.74532509354;10133.240006999431;10142.290039697224;10168.847467287997;10213.591456341812;10301.484925753683;3247.594050743657;3264.3308121834966;3324.202191474029;3395.711364534018;3398.3882901077795;45257.321140182925;45346.31980520295;45475.54524454746;46039.76980115112;46085.53914460846;9740.512974351253;9789.167920726675;9955.651552195639;10105.44420056904;10109.292349535463;17438.65122697539;17465;17485;17491.825081749274;17506;6409.967950160312;6542.705578248991;6610.438112760469;6614.9416093424825;6756;3790.6967442604528;3817.656410922975;3823.6941044716355;3862.671672907778;3922.6077392260545;2768.460150270678;2801.061644349125;2808.199663096008;2810.423863108058;2812.1844665047315;472.6431544184119;482.6717831874289;482.73449602718364;489.2587729589674;502.82903812703125;597.1520440973827;605.7183409714415;607.4866737606716;609.1624016976657;617.0497433951664;7938.9206107939335;8135.959320203361;8193.221643943816;8205.384596155312;8292.33661307094;589.7965202005302;589.9616524925866;590.2032256453839;594.3669991459083;608.3612207182529;3817.351050321452;3897.512810898638;3903.6486716195677;3921.5490218625223;4061;46794.766026170335;48024.7598762004;49402.258966114816;49973.75013124911;50233.74883125561;44096.55903440989;44964;45313.093738125055;45487.77256113698;45744.77127614341;40588.18823623511;40632.39051414231;41010;41046.1790764183;41519.792401037805;7660.619860089499;7776.766696999099;7869.6458659361615;7987.121416644049;8123.959380203061;30423.54364684487;31262.843685781427;31352.52971205388;31933.36133277275;32236.19409514687;38185.6181438182;38879.222415552096;38960;39429.01427464221;39981;10257.076863082359;10320.174386048948;10399.49397098313;10401.68794936153;10685.893141068489;11134.610288639858;11244.26912250701;11353.602623908124;11386.715332116763;11546.94226528862;8405.22289015535;11021.944890275498;11183.888161118284;11244.156688248579;11810.468528916048;10981.341119532854;11480.655580332603;11552.59565915189;11585.536578536765;11623;10696.679099626712;10730;11265.042471390023;11316.94341528287;11349.829752553553;9390.483523406278;9414.858777118212;9417.717468475958;9626.66306679263;9815.263855211031;9792.216622670312;9853.655122070693;9888.950555247178;9890.307678462726;9904.851427228741 01:07:50 INFO - PROCESS | 6353 | __end_tp_report 01:07:50 INFO - PROCESS | 6353 | __start_cc_report 01:07:50 INFO - PROCESS | 6353 | _x_x_mozilla_cycle_collect,855 01:07:50 INFO - PROCESS | 6353 | __end_cc_report 01:07:50 INFO - PROCESS | 6353 | __startTimestamp1460016470981__endTimestamp 01:07:50 INFO - PROCESS | 6353 | 01:07:50 INFO - PROCESS | 6353 | ------- Summary: start ------- 01:07:50 INFO - PROCESS | 6353 | Number of tests: 6 01:07:50 INFO - PROCESS | 6353 | 01:07:50 INFO - PROCESS | 6353 | [#0] dojo.html Cycles:165 Average:4594.52 Median:4709.86 stddev:460.72 (9.8%) stddev-sans-first:434.75 01:07:50 INFO - PROCESS | 6353 | Values: 2600.2 2675.8 2682.0 2691.0 2713.5 4518.8 4634.7 4638.9 4647.9 4656.4 4567.5 4594.6 4661.3 4693.5 4696.6 4290.1 4298.3 4345.3 4371.0 4453.6 4370.9 4398.3 4413.0 4419.3 4444.4 4183.5 4209.9 4279.7 4312.4 4314.5 4307.2 4309.2 4311.4 4346.0 4354.6 4271.5 4298.7 4300.7 4312.6 4327.2 4400.1 4455.8 4548.3 4556.2 4565.9 4920.4 4957.6 4959.1 4961.5 4965.1 4964.8 4967.1 4984.0 4987.3 5025.8 4488.9 4607.2 4698.7 4704.1 4704.6 5067.3 5077.1 5092.7 5094.6 5142.8 4810.5 4869.7 4877.2 4879.2 4904.6 4976.8 5009.2 5034.7 5062.3 5077.0 4887.7 4888.6 4889.8 4908.1 4944.5 4758.0 4877.0 4892.9 4903.8 4934.3 4216.4 4238.5 4240.7 4272.3 4282.5 3691.4 3702.7 3710.0 3725.2 3740.0 4170.2 4239.9 4328.2 4328.7 4341.7 4908.5 4969.5 4970.7 4971.0 5019.8 4300.3 4301.7 4301.9 4307.3 4343.0 4267.5 4466.6 4479.3 4495.2 4542.3 4709.9 4710.1 4713.6 4734.2 4739.4 4970.0 4976.9 4979.4 4981.3 5036.4 4606.4 4652.8 4696.1 4731.3 4753.9 4893.7 4896.5 4900.7 4909.6 4962.3 4944.8 4959.8 4983.4 4984.8 5031.5 4691.1 4752.4 4819.5 4840.6 4864.1 4776.9 4779.9 4800.4 4807.5 4829.5 4650.0 4702.1 4719.7 4720.6 4767.6 4827.8 4863.0 4881.2 4899.6 4924.5 4679.1 4728.3 4728.6 4730.7 4781.3 01:07:50 INFO - PROCESS | 6353 | 01:07:50 INFO - PROCESS | 6353 | [#1] ext.html Cycles:180 Average:47706.32 Median:3337.34 stddev:97561.42 (2923.3%) stddev-sans-first:97770.82 01:07:50 INFO - PROCESS | 6353 | Values: 532.8 550.3 559.7 562.7 565.8 37541.6 38008.2 38046.0 38100.6 38123.0 39171.2 39869.2 39890.4 39908.2 39938.0 7531.3 7566.8 7679.7 7688.2 7832.4 7658.6 7799.1 10026.1 10335.3 10355.7 9935.9 10043.7 10048.7 10049.4 10050.0 10174.4 10270.6 10272.0 10272.8 10273.6 7598.7 10002.8 10264.1 10265.9 10273.3 38995.2 39112.8 39449.4 39455.0 39591.4 3148.2 3216.9 3262.8 3411.9 3646.6 29147.6 29209.3 29685.4 29869.9 30200.8 3579.4 3580.4 3646.6 3651.8 3763.2 243800.8 246123.0 246584.0 247143.0 247268.0 43258.8 57344.0 57705.1 57712.7 57801.0 40549.8 40837.0 40842.0 40845.4 40855.8 13372.3 13459.8 13474.3 13488.7 13493.2 11709.4 11860.2 11862.1 11879.9 11891.0 14714.8 14773.5 14804.5 14846.8 14860.9 5541.4 5745.0 5826.2 5841.2 5878.6 889.7 915.0 925.4 976.0 1055.2 26385.7 27259.5 27855.2 28033.9 28154.9 1058.0 1079.3 1090.5 1104.5 1134.1 13838.2 14224.7 14378.8 14670.3 14682.3 275907.0 587506.0 591316.0 591673.0 593792.0 48928.8 49700.3 50140.0 50246.7 50290.0 1117.9 1193.8 1245.7 1278.5 1289.4 27059.9 28684.4 29226.3 29633.9 29749.4 36012.0 36465.1 36509.3 36584.1 37413.8 204789.0 206616.0 206661.0 206686.0 207000.0 30927.7 32393.5 32457.0 32507.0 32526.3 39540.0 40457.6 40916.4 41012.6 41343.4 34968.7 35081.5 35352.5 35503.8 35786.5 34546.7 34817.7 34851.7 34971.0 35276.6 34331.5 34906.8 34931.5 35248.8 35267.0 29771.6 31395.2 31417.7 31608.0 31667.4 24421.3 24646.4 24647.1 24929.4 25028.6 01:07:51 INFO - PROCESS | 6353 | 01:07:51 INFO - PROCESS | 6353 | [#2] jquery.html Cycles:180 Average:23575.31 Median:4453.61 stddev:63854.44 (1433.8%) stddev-sans-first:64009.73 01:07:51 INFO - PROCESS | 6353 | Values: 336.0 346.2 347.5 351.0 355.4 14934.6 15377.5 15971.9 16776.2 16826.5 15842.0 16078.0 17142.9 17228.1 17240.7 4930.9 5006.3 5032.6 5077.5 5089.3 4766.6 4964.9 4997.8 4999.4 5015.3 4978.0 4982.2 4985.6 4989.4 4992.5 4771.6 5001.9 5004.3 5006.0 5007.4 4445.7 4461.5 4465.0 4467.6 4468.6 19111.2 19889.1 20143.7 20155.6 20176.5 2035.7 2088.6 2137.5 2210.8 2431.7 12555.1 12748.8 12776.9 12825.4 13265.7 1719.6 1761.1 1780.5 1787.6 1803.3 62107.4 65934.3 66265.7 66846.3 67242.3 9300.4 9541.2 9741.8 9766.4 9867.4 13189.7 13304.7 13307.4 13313.6 13314.1 7226.5 7333.3 7360.4 7409.1 7424.4 6740.9 6759.4 6852.2 6881.6 6964.4 4179.1 4210.7 4216.5 4227.0 4283.1 1722.6 1729.5 1756.5 1791.9 1792.7 827.2 831.3 925.6 970.7 976.1 16111.1 16305.9 16424.3 16535.8 16987.7 853.4 862.8 869.4 880.4 959.5 6729.9 8816.4 8921.7 8929.2 9035.5 357491.0 368015.0 397689.0 406301.0 408220.0 67636.0 71201.0 71702.0 71725.6 73044.3 969.4 971.6 975.4 987.3 1000.6 13949.4 14228.9 14301.6 14370.1 14569.7 29780.1 30347.5 30824.5 31891.5 32239.5 46212.3 46548.3 46834.3 47151.3 47445.0 7389.5 7418.4 7646.3 7714.8 7722.8 9148.3 11076.9 11711.2 11954.5 12083.8 9358.3 10161.4 10275.3 10571.6 10946.6 9915.2 10209.3 10365.6 10375.7 10903.0 10146.1 10868.5 10916.1 10929.8 11091.9 7390.3 7550.5 7600.9 7741.7 7989.0 7937.0 9387.2 9868.3 10159.5 10281.7 01:07:51 INFO - PROCESS | 6353 | 01:07:51 INFO - PROCESS | 6353 | [#3] mootools.html Cycles:180 Average:5267.83 Median:6427.15 stddev:2785.46 (43.3%) stddev-sans-first:2777.31 01:07:51 INFO - PROCESS | 6353 | Values: 1300.2 1395.2 1405.2 1558.7 1755.1 6541.8 6862.5 6947.5 6972.0 6972.8 7281.1 7424.0 7431.0 7434.2 7442.9 1893.2 1930.8 1940.0 2119.5 2143.1 2161.9 2222.0 2223.4 2223.7 2225.8 2090.8 2112.9 2127.1 2131.3 2153.3 2120.0 2123.3 2125.7 2130.6 2131.3 2045.2 2088.7 2093.6 2103.2 2106.6 7579.4 7613.2 7617.7 7628.5 7636.0 4513.1 4642.6 4647.7 4667.2 4678.9 2917.9 2996.9 3013.4 3023.7 3031.4 931.6 953.6 965.1 967.6 988.4 10416.2 10418.2 10428.8 10429.9 10446.6 4154.6 4157.4 4255.8 4288.6 4291.1 8899.2 8937.8 8959.3 8972.8 8986.0 4684.7 4690.2 4702.2 4702.2 4707.8 3670.6 4004.8 4078.0 4178.9 4194.6 3448.5 3468.4 3474.3 3494.8 3528.7 1157.6 1162.9 1165.3 1168.5 1191.2 1183.3 1188.3 1208.5 1222.7 1237.1 7045.6 7175.3 7221.0 7223.6 7299.5 413.2 428.5 448.0 448.3 449.0 5482.3 5507.5 5513.3 5517.7 5558.8 8730.5 9052.8 9248.1 9273.7 9360.8 9095.6 9145.2 9276.4 9281.6 9293.2 7011.2 7140.5 7148.1 7213.7 7216.7 6772.4 6813.4 6820.1 6839.4 6847.3 7923.6 8126.1 8128.6 8316.0 8327.4 8250.7 8397.0 8555.0 8566.3 8573.1 6571.0 6572.8 6676.3 6730.6 6755.1 7196.2 7198.2 7236.6 7236.6 7277.0 6457.9 6528.3 6618.1 6618.2 6817.9 6367.3 6397.5 6593.5 6626.9 6657.2 6932.8 6968.5 6970.8 6988.1 6994.9 6194.9 6404.5 6410.1 6420.6 6433.6 6438.3 6458.6 6501.4 6509.4 6511.9 01:07:51 INFO - PROCESS | 6353 | 01:07:51 INFO - PROCESS | 6353 | [#4] prototype.html Cycles:180 Average:4671.43 Median:5370.63 stddev:1350.07 (25.1%) stddev-sans-first:1313.47 01:07:51 INFO - PROCESS | 6353 | Values: 305.0 305.9 307.7 310.6 316.0 5369.0 5372.2 5373.8 5424.3 5429.4 5315.9 5318.0 5329.1 5338.6 5347.3 3960.2 4039.9 4177.5 4180.3 4181.9 4176.2 4189.6 4192.3 4192.4 4193.0 4139.2 4152.5 4154.2 4161.3 4162.9 3946.2 4055.6 4155.9 4179.4 4187.9 3672.7 3673.2 3681.5 3684.3 3686.1 5110.7 5127.1 5130.3 5132.3 5133.2 4811.1 4815.2 4821.6 4822.2 4823.6 5597.5 5635.6 5639.7 5645.9 5647.1 4037.1 4041.8 4044.2 4048.1 4049.5 5740.7 5911.6 5912.1 5915.9 5918.2 4123.0 4139.0 4142.4 4142.8 4148.1 4162.4 4164.4 4197.9 4198.6 4215.8 4751.3 4758.3 4783.7 4793.3 4797.4 5611.6 5617.0 5630.0 5631.5 5633.1 1462.2 1485.9 1488.0 1488.8 1493.9 937.5 985.4 987.7 995.3 999.0 4888.0 4912.2 4925.9 4942.6 4947.1 5799.0 5799.6 5805.4 5808.6 5815.9 4928.7 4931.5 4938.9 4941.0 4941.5 3089.1 3118.4 3122.6 3124.4 3128.2 5453.9 5455.8 5464.8 5466.3 5472.9 5773.4 5940.9 5942.8 5944.1 5945.3 5390.5 5416.3 5434.1 5442.8 5448.9 5819.0 5845.0 5850.3 5851.4 5852.7 5609.3 5634.9 5648.4 5649.5 5654.7 5429.6 5431.4 5441.5 5446.4 5448.4 4059.5 4160.0 4170.4 4171.0 4180.6 5724.6 5746.9 5761.4 5765.2 5776.8 5553.2 5555.0 5556.7 5559.2 5559.9 5554.9 5562.4 5563.7 5564.0 5568.4 5477.8 5479.0 5482.0 5491.6 5495.8 5503.1 5634.8 5640.4 5690.6 5721.4 5516.7 5556.0 5572.5 5574.1 5578.6 01:07:51 INFO - PROCESS | 6353 | 01:07:51 INFO - PROCESS | 6353 | [#5] yui.html Cycles:180 Average:12743.40 Median:42808.18 stddev:14072.33 (32.9%) stddev-sans-first:14082.98 01:07:51 INFO - PROCESS | 6353 | Values: 749.1 761.6 764.7 775.9 786.7 14067.7 14375.1 14388.8 14395.6 14405.2 14119.9 14151.6 14152.2 14162.3 14219.1 656.7 806.4 811.2 829.8 831.4 806.9 814.8 815.4 817.2 817.3 855.0 861.3 863.2 865.7 866.5 682.8 838.1 855.9 859.4 860.7 616.7 618.0 618.1 618.2 619.5 11847.6 11878.3 11884.9 11912.7 11936.3 11850.0 12256.8 12368.6 12655.9 12733.7 10133.2 10142.3 10168.8 10213.6 10301.5 3247.6 3264.3 3324.2 3395.7 3398.4 45257.3 45346.3 45475.5 46039.8 46085.5 9740.5 9789.2 9955.7 10105.4 10109.3 17438.7 17465.0 17485.0 17491.8 17506.0 6410.0 6542.7 6610.4 6614.9 6756.0 3790.7 3817.7 3823.7 3862.7 3922.6 2768.5 2801.1 2808.2 2810.4 2812.2 472.6 482.7 482.7 489.3 502.8 597.2 605.7 607.5 609.2 617.0 7938.9 8136.0 8193.2 8205.4 8292.3 589.8 590.0 590.2 594.4 608.4 3817.4 3897.5 3903.6 3921.5 4061.0 46794.8 48024.8 49402.3 49973.8 50233.7 44096.6 44964.0 45313.1 45487.8 45744.8 40588.2 40632.4 41010.0 41046.2 41519.8 7660.6 7776.8 7869.6 7987.1 8124.0 30423.5 31262.8 31352.5 31933.4 32236.2 38185.6 38879.2 38960.0 39429.0 39981.0 10257.1 10320.2 10399.5 10401.7 10685.9 11134.6 11244.3 11353.6 11386.7 11546.9 8405.2 11021.9 11183.9 11244.2 11810.5 10981.3 11480.7 11552.6 11585.5 11623.0 10696.7 10730.0 11265.0 11316.9 11349.8 9390.5 9414.9 9417.7 9626.7 9815.3 9792.2 9853.7 9889.0 9890.3 9904.9 01:07:51 INFO - PROCESS | 6353 | -------- Summary: end -------- 01:07:51 INFO - PROCESS | 6353 | 01:07:51 INFO - TEST-INFO | 6353: exit 0 01:07:51 INFO - TEST-OK | dromaeo_css | took 1116593ms 01:07:51 INFO - TEST-START | kraken 01:07:51 INFO - operating with platform_type : linux_ 01:07:51 INFO - Initialising browser for kraken test... 01:07:51 INFO - TEST-INFO | started process 6530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaBHiNh/profile http://localhost:38119/getInfo.html) 01:07:56 INFO - PROCESS | 6530 | __metrics Screen width/height:1600/1200 01:07:56 INFO - PROCESS | 6530 | colorDepth:24 01:07:56 INFO - PROCESS | 6530 | Browser inner width/height: 1024/697 01:07:56 INFO - PROCESS | 6530 | __metrics 01:07:57 ERROR - PROCESS | 6530 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:07:57 INFO - TEST-INFO | 6530: exit 0 01:07:57 INFO - Browser initialized. 01:07:57 INFO - Running cycle 1/1 for kraken test... 01:07:58 INFO - TEST-INFO | started process 6612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaBHiNh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:08:09 INFO - PROCESS | 6612 | RSS: Main: 154644480 01:08:09 INFO - PROCESS | 6612 | 01:08:12 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38119/tests/kraken/driver.html?testName=audio-beat-detection) 01:08:13 INFO - PROCESS | 6612 | RSS: Main: 195948544 01:08:13 INFO - PROCESS | 6612 | 01:08:15 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38119/tests/kraken/driver.html?testName=audio-dft) 01:08:16 INFO - PROCESS | 6612 | RSS: Main: 186294272 01:08:16 INFO - PROCESS | 6612 | 01:08:19 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38119/tests/kraken/driver.html?testName=audio-fft) 01:08:20 INFO - PROCESS | 6612 | RSS: Main: 171180032 01:08:20 INFO - PROCESS | 6612 | 01:08:22 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38119/tests/kraken/driver.html?testName=audio-oscillator) 01:08:22 INFO - PROCESS | 6612 | RSS: Main: 172363776 01:08:22 INFO - PROCESS | 6612 | 01:08:25 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:08:25 INFO - PROCESS | 6612 | RSS: Main: 173207552 01:08:25 INFO - PROCESS | 6612 | 01:08:28 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38119/tests/kraken/driver.html?testName=imaging-darkroom) 01:08:29 INFO - PROCESS | 6612 | RSS: Main: 174301184 01:08:29 INFO - PROCESS | 6612 | 01:08:32 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38119/tests/kraken/driver.html?testName=imaging-desaturate) 01:08:33 INFO - PROCESS | 6612 | RSS: Main: 175316992 01:08:33 INFO - PROCESS | 6612 | 01:08:36 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38119/tests/kraken/driver.html?testName=json-parse-financial) 01:08:36 INFO - PROCESS | 6612 | RSS: Main: 174637056 01:08:36 INFO - PROCESS | 6612 | 01:08:38 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:08:39 INFO - PROCESS | 6612 | RSS: Main: 186900480 01:08:39 INFO - PROCESS | 6612 | 01:08:41 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:08:41 INFO - PROCESS | 6612 | RSS: Main: 185405440 01:08:41 INFO - PROCESS | 6612 | 01:08:43 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:08:44 INFO - PROCESS | 6612 | RSS: Main: 195223552 01:08:44 INFO - PROCESS | 6612 | 01:08:46 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:08:47 INFO - PROCESS | 6612 | RSS: Main: 197963776 01:08:47 INFO - PROCESS | 6612 | 01:08:50 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:08:50 INFO - PROCESS | 6612 | RSS: Main: 198406144 01:08:50 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:38119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38119/tests/kraken/driver.html?testName=ai-astar) 01:08:52 INFO - PROCESS | 6612 | RSS: Main: 259706880 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | __start_tp_report 01:08:52 INFO - PROCESS | 6612 | _x_x_mozilla_page_load 01:08:52 INFO - PROCESS | 6612 | _x_x_mozilla_page_load_details 01:08:52 INFO - PROCESS | 6612 | |i|pagename|runs| 01:08:52 INFO - PROCESS | 6612 | |0;ai-astar;112;114;109;111;114;114;102;116;114;113 01:08:52 INFO - PROCESS | 6612 | |1;audio-beat-detection;163;138;161;169;140;162;163;132;181;140 01:08:52 INFO - PROCESS | 6612 | |2;audio-dft;162;163;162;163;162;164;165;165;164;163 01:08:52 INFO - PROCESS | 6612 | |3;audio-fft;74;74;108;108;74;74;73;121;93;77 01:08:52 INFO - PROCESS | 6612 | |4;audio-oscillator;93;96;136;94;94;93;130;94;94;140 01:08:52 INFO - PROCESS | 6612 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;116;117 01:08:52 INFO - PROCESS | 6612 | |6;imaging-darkroom;146;147;146;145;146;145;146;146;146;146 01:08:52 INFO - PROCESS | 6612 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 01:08:52 INFO - PROCESS | 6612 | |8;json-parse-financial;65;66;66;66;67;65;66;76;63;64 01:08:52 INFO - PROCESS | 6612 | |9;json-stringify-tinderbox;64;63;63;62;64;63;63;63;63;65 01:08:52 INFO - PROCESS | 6612 | |10;stanford-crypto-aes;82;81;84;83;82;83;83;84;83;84 01:08:52 INFO - PROCESS | 6612 | |11;stanford-crypto-ccm;122;127;118;117;131;115;116;117;117;129 01:08:52 INFO - PROCESS | 6612 | |12;stanford-crypto-pbkdf2;132;129;150;138;140;127;141;141;138;146 01:08:52 INFO - PROCESS | 6612 | |13;stanford-crypto-sha256-iterative;68;67;68;68;67;67;68;66;66;65 01:08:52 INFO - PROCESS | 6612 | __end_tp_report 01:08:52 INFO - PROCESS | 6612 | __start_cc_report 01:08:52 INFO - PROCESS | 6612 | _x_x_mozilla_cycle_collect,1186 01:08:52 INFO - PROCESS | 6612 | __end_cc_report 01:08:52 INFO - PROCESS | 6612 | __startTimestamp1460016532634__endTimestamp 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | ------- Summary: start ------- 01:08:52 INFO - PROCESS | 6612 | Number of tests: 14 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#0] ai-astar Cycles:10 Average:111.90 Median:114.00 stddev:3.98 (3.5%) stddev-sans-first:4.23 01:08:52 INFO - PROCESS | 6612 | Values: 112.0 114.0 109.0 111.0 114.0 114.0 102.0 116.0 114.0 113.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:162.50 stddev:16.17 (10.0%) stddev-sans-first:16.88 01:08:52 INFO - PROCESS | 6612 | Values: 163.0 138.0 161.0 169.0 140.0 162.0 163.0 132.0 181.0 140.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.16 (0.7%) stddev-sans-first:1.13 01:08:52 INFO - PROCESS | 6612 | Values: 162.0 163.0 162.0 163.0 162.0 164.0 165.0 165.0 164.0 163.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#3] audio-fft Cycles:10 Average:87.60 Median:74.00 stddev:18.39 (24.8%) stddev-sans-first:18.83 01:08:52 INFO - PROCESS | 6612 | Values: 74.0 74.0 108.0 108.0 74.0 74.0 73.0 121.0 93.0 77.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:94.00 stddev:20.12 (21.4%) stddev-sans-first:20.75 01:08:52 INFO - PROCESS | 6612 | Values: 93.0 96.0 136.0 94.0 94.0 93.0 130.0 94.0 94.0 140.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:08:52 INFO - PROCESS | 6612 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 01:08:52 INFO - PROCESS | 6612 | Values: 146.0 147.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:08:52 INFO - PROCESS | 6612 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.00 stddev:3.57 (5.4%) stddev-sans-first:3.75 01:08:52 INFO - PROCESS | 6612 | Values: 65.0 66.0 66.0 66.0 67.0 65.0 66.0 76.0 63.0 64.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 01:08:52 INFO - PROCESS | 6612 | Values: 64.0 63.0 63.0 62.0 64.0 63.0 63.0 63.0 63.0 65.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 01:08:52 INFO - PROCESS | 6612 | Values: 82.0 81.0 84.0 83.0 82.0 83.0 83.0 84.0 83.0 84.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:120.00 stddev:5.95 (5.0%) stddev-sans-first:6.30 01:08:52 INFO - PROCESS | 6612 | Values: 122.0 127.0 118.0 117.0 131.0 115.0 116.0 117.0 117.0 129.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.20 Median:140.50 stddev:7.21 (5.1%) stddev-sans-first:7.29 01:08:52 INFO - PROCESS | 6612 | Values: 132.0 129.0 150.0 138.0 140.0 127.0 141.0 141.0 138.0 146.0 01:08:52 INFO - PROCESS | 6612 | 01:08:52 INFO - PROCESS | 6612 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.05 (1.6%) stddev-sans-first:1.05 01:08:52 INFO - PROCESS | 6612 | Values: 68.0 67.0 68.0 68.0 67.0 67.0 68.0 66.0 66.0 65.0 01:08:52 INFO - PROCESS | 6612 | -------- Summary: end -------- 01:08:52 INFO - PROCESS | 6612 | 01:08:53 INFO - TEST-INFO | 6612: exit 0 01:08:53 INFO - TEST-OK | kraken | took 61872ms 01:08:53 INFO - SUITE-END | took 1178s 01:08:53 INFO - Completed test suite (00:19:38) 01:08:53 INFO - javascript benchmark 01:08:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2600.1939398786376, 2675.8020923715203, 2682.0210623122543, 2691.031228757647, 2713.5386984212682, 4518.8418405355815, 4634.675572709912, 4638.860834174976, 4647.907041859165, 4656.441227052755, 4567.474740404855, 4594.58648721615, 4661.324108004337, 4693.483716791159, 4696.600788932937, 4290.056187638715, 4298.269294219982, 4345.3047512398025, 4371.038371558252, 4453.554644535553, 4370.868873933787, 4398.318260669601, 4412.977935110336, 4419.337099435078, 4444.422225110731, 4183.539810620845, 4209.894752631178, 4279.657627389833, 4312.396264522969, 4314.546972567867, 4307.181635489247, 4309.245881970643, 4311.417958575615, 4345.978270108661, 4354.608085272309, 4271.530131685512, 4298.656107511423, 4300.741955482681, 4312.61186493214, 4327.221100201962, 4400.09797991411, 4455.844045458393, 4548.295014272793, 4556.248219043854, 4565.863024109282, 4920.40955085392, 4957.628177886637, 4959.057779021974, 4961.5038496150455, 4965.131102057126, 4964.826231081895, 4967.05625931072, 4984.0281145176705, 4987.251912213161, 5025.798968041274, 4488.910221795546, 4607.216773148606, 4698.718076915396, 4704.1062198182235, 4704.623630109583, 5067.341245638044, 5077.111505486525, 5092.719900405513, 5094.61790365724, 5142.820001300011, 4810.494898035726, 4869.683470574401, 4877.219644856806, 4879.194932836042, 4904.583110435653, 4976.825811096594, 5009.223570346602, 5034.672746271481, 5062.316587260746, 5076.974615126901, 4887.73117478535, 4888.633352498577, 4889.804407823718, 4908.141075311878, 4944.480829512921, 4757.976210118927, 4876.975615121902, 4892.877678058006, 4903.828366007244, 4934.309196712463, 4216.409702641633, 4238.470191226097, 4240.660747140283, 4272.273713468656, 4282.464691913511, 3691.409374500121, 3702.740808143404, 3709.9629003710156, 3725.1990821972863, 3740.0275928258848, 4170.249355116108, 4239.894002649959, 4328.156009578165, 4328.7402755834755, 4341.6526677865695, 4908.509149085135, 4969.453360130383, 4970.65205435616, 4970.950290497121, 5019.824306149268, 4300.2904520754355, 4301.741895486281, 4301.935470967938, 4307.267764480046, 4342.978285108554, 4267.487901451846, 4466.598006179394, 4479.260921947907, 4495.235809912323, 4542.273236282179, 4709.858704238878, 4710.081534100817, 4713.599344055657, 4734.242521196592, 4739.4075740532435, 4969.950300496948, 4976.850694479172, 4979.377577802775, 4981.302617633607, 5036.420811606566, 4606.401167848158, 4652.790624421841, 4696.060787842377, 4731.266653668687, 4753.857384278339, 4893.657443978887, 4896.461389247252, 4900.705957642553, 4909.631777616622, 4962.280469331999, 4944.752762361795, 4959.809645685082, 4983.426905905722, 4984.825531106394, 5031.52200540948, 4691.08523837862, 4752.382190315375, 4819.469858315652, 4840.564349208588, 4864.051509955525, 4776.928346074881, 4779.856604301876, 4800.423949126127, 4807.471178170328, 4829.541193586604, 4649.976750116363, 4702.106599746037, 4719.716816990855, 4720.551547602972, 4767.570918617341, 4827.831025914076, 4863.0, 4881.170201065898, 4899.559039686445, 4924.458309586014, 4679.087577922272, 4728.267118596623, 4728.550787675165, 4730.739809310521, 4781.282807578891], "unit": "score", "name": "dojo.html", "value": 4566.651254933636}, {"lowerIsBetter": false, "replicates": [532.78155956058, 550.2599004339165, 559.7145455817532, 562.7327019665656, 565.7934853778371, 37541.62458375416, 38008.239835203276, 38046.0, 38100.61899381005, 38123.0, 39171.21657566854, 39869.202615947666, 39890.40164397536, 39908.201835963264, 39938.0, 7531.3221810037085, 7566.772996810105, 7679.6928122875015, 7688.1927397623285, 7832.373410127205, 7658.578778167199, 7799.142094369643, 10026.09765121139, 10335.328203666775, 10355.689329320132, 9935.850962235572, 10043.74890627733, 10048.69853904384, 10049.397036177852, 10050.045245701684, 10174.44040577768, 10270.589176432934, 10272.0, 10272.794544109076, 10273.640422585248, 7598.658060387296, 10002.849957250646, 10264.076233139054, 10265.948670256601, 10273.28087033908, 38995.22009559793, 39112.80443597792, 39449.40825887614, 39455.0, 39591.40612890809, 3148.2286839724416, 3216.935661286761, 3262.820544870031, 3411.8635254589785, 3646.5806432260365, 29147.562786558006, 29209.269768255752, 29685.406291874042, 29869.850650746823, 30200.8489957551, 3579.391503444421, 3580.3929916975685, 3646.6171052039685, 3651.8174091295596, 3763.209725957552, 243800.78099609565, 246123.0, 246584.0, 247143.0, 247268.0, 43258.7837060819, 57344.0, 57705.13442298369, 57712.71143644255, 57801.0, 40549.79725101356, 40837.0, 40842.0, 40845.38731919024, 40855.7957210218, 13372.33138343079, 13459.798103028463, 13474.258915759532, 13488.730225395633, 13493.190408575518, 11709.414529273503, 11860.169788114748, 11862.110341724232, 11879.940600296943, 11891.04871610269, 14714.779278310834, 14773.482928097465, 14804.483237849592, 14846.777298340534, 14860.925695371454, 5541.362743284493, 5744.971275143597, 5826.242588463558, 5841.153032810219, 5878.588498805128, 889.7286327670123, 914.9862752058724, 925.3846192282192, 975.9707208783748, 1055.1664185293685, 26385.73614263871, 27259.45481090367, 27855.16434506968, 28033.859830700716, 28154.85922570374, 1057.9894201057891, 1079.3469950679726, 1090.4711215060688, 1104.5195340027115, 1134.0983917785381, 13838.238896860568, 14224.715505690036, 14378.784318235235, 14670.266486675624, 14682.339294731762, 275907.0, 587506.0, 591316.0, 591673.0, 593792.0, 48928.75535622299, 49700.254496182584, 50140.0, 50246.748766255936, 50290.0, 1117.9385133817555, 1193.785118678646, 1245.688577855536, 1278.469435184388, 1289.374653293152, 27059.86470067637, 28684.422356770578, 29226.269343265736, 29633.851830740707, 29749.40501189921, 36012.0, 36465.088372790895, 36509.26981460409, 36584.085397864204, 37413.81293093517, 204789.0, 206616.0, 206661.0, 206686.0, 207000.0, 30927.69072309338, 32393.51409728903, 32457.0, 32507.0, 32526.34947301088, 39540.0, 40457.59542404538, 40916.386254205616, 41012.58987410088, 41343.37984930168, 34968.65031349756, 35081.473777893865, 35352.46971295381, 35503.82248088743, 35786.463203051455, 34546.65453345434, 34817.65182348144, 34851.65148348484, 34971.0, 35276.647233527336, 34331.4850277251, 34906.825465872505, 34931.47602785909, 35248.82375588106, 35267.0, 29771.55342669905, 31395.21511962128, 31417.68582314239, 31608.0, 31667.36665266728, 24421.267361979168, 24646.383840403418, 24647.137350192657, 24929.376765581004, 25028.62457063109], "unit": "score", "name": "ext.html", "value": 17665.39658665523}, {"lowerIsBetter": false, "replicates": [335.9630440651528, 346.1553808706755, 347.45796557370505, 350.9596396414413, 355.37099334178504, 14934.551963441087, 15377.538673839776, 15971.920140399296, 16776.161191940417, 16826.495205143834, 15842.049477031358, 16078.0, 17142.914285428556, 17228.052457114853, 17240.741388879178, 4930.852074437773, 5006.324146240266, 5032.622553308516, 5077.543021128097, 5089.287499750038, 4766.571008609225, 4964.900701985958, 4997.825076122336, 4999.425066117388, 5015.32293140425, 4977.950220497785, 4982.153033984213, 4985.6260780441435, 4989.376327959005, 4992.525710057557, 4771.570558649721, 5001.949980500185, 5004.349434573519, 5006.0, 5007.4491805901325, 4445.73325600465, 4461.486929003174, 4465.040016396458, 4467.6425885929375, 4468.575485328888, 19111.23555057796, 19889.10499027547, 20143.697844532344, 20155.596888062304, 20176.49558761028, 2035.6539388303877, 2088.5822835432973, 2137.4763183020104, 2210.823134149264, 2431.732509423962, 12555.121141520005, 12748.80876786849, 12776.87223127766, 12825.422855971503, 13265.734685306335, 1719.604490967072, 1761.1282415204555, 1780.4569606270084, 1787.6245988342464, 1803.3057272949877, 62107.378926210615, 65934.34065659378, 66265.66867165682, 66846.33153668449, 67242.3275767241, 9300.39547429415, 9541.2367010639, 9741.805163896683, 9766.414015159113, 9867.40795552269, 13189.670258243621, 13304.733905322033, 13307.401166947511, 13313.600591982256, 13314.134581252187, 7226.494145409876, 7333.266673332624, 7360.374368178765, 7409.073865766779, 7424.443166762514, 6740.898886516608, 6759.357861003196, 6852.177738671391, 6881.552699074544, 6964.373206411447, 4179.101493178981, 4210.7473551587, 4216.47294088239, 4227.013303747234, 4283.057727299989, 1722.5607470095297, 1729.5416714570397, 1756.4993976716573, 1791.9283228670968, 1792.6683563540787, 827.2389401750404, 831.339085427087, 925.6019911438146, 970.737900766789, 976.1117383181271, 16111.113888736232, 16305.918470407572, 16424.260908259155, 16535.751963720555, 16987.74518382225, 853.3557164340883, 862.7799911022774, 869.4479005831342, 880.41892351048, 959.4722902403789, 6729.865402692017, 8816.426932249384, 8921.687740929035, 8929.24101451371, 9035.50304733246, 357491.0, 368015.0, 397689.0, 406301.0, 408220.0, 67636.0, 71201.0, 71702.0, 71725.64137179281, 73044.26955730375, 969.3989726369696, 971.5919313888184, 975.3513913247752, 987.2792861211356, 1000.5747557288123, 13949.372278247707, 14228.928855355656, 14301.57095287143, 14370.13779173253, 14569.708605828037, 29780.106596801263, 30347.544786827773, 30824.53763193509, 31891.521627176076, 32239.516407253443, 46212.306815397125, 46548.30177547272, 46834.297485538424, 47151.29273060838, 47445.0, 7389.5437955292655, 7418.443616728875, 7646.273604007611, 7714.80420534818, 7722.768316950501, 9148.313876459159, 11076.944615276872, 11711.238769479956, 11954.462049207632, 12083.818742718691, 9358.298127640319, 10161.441120738134, 10275.332103413255, 10571.62999295021, 10946.562137514411, 9915.20678345745, 10209.285350025428, 10365.585376584851, 10375.688729338131, 10903.0, 10146.068918376877, 10868.456577170951, 10916.12670986335, 10929.78140437171, 11091.889081109086, 7390.334869861738, 7550.471466997477, 7600.885986710315, 7741.690332386642, 7988.960055199686, 7936.968194134956, 9387.202087822612, 9868.259880509135, 10159.492025398553, 10281.691549253534], "unit": "score", "name": "jquery.html", "value": 8018.981936964889}, {"lowerIsBetter": false, "replicates": [1300.2068738069781, 1395.2117053864565, 1405.206058576904, 1558.6648870492843, 1755.148752854866, 6541.803745887625, 6862.519623626348, 6947.548409353389, 6971.999999999994, 6972.7908162755075, 7281.089863767029, 7423.962880185605, 7430.962845185766, 7434.182239953614, 7442.8883566746545, 1893.1575448925164, 1930.7779605345424, 1940.049375805852, 2119.459537817854, 2143.07847625521, 2161.8919054047315, 2221.9666704999436, 2223.3885681437655, 2223.6664500325, 2225.7774222577773, 2090.7595626502994, 2112.9366119016377, 2127.0959842067136, 2131.3499382688274, 2153.257126291427, 2119.957600847982, 2123.309924274617, 2125.744910610721, 2130.605837919982, 2131.3073251193346, 2045.2228153301799, 2088.697138914849, 2093.5603523259983, 2103.2112957640884, 2106.568153528523, 7579.355754760852, 7613.238676132398, 7617.6572054257695, 7628.504147230412, 7635.961820190919, 4513.0973805238755, 4642.628589712815, 4647.721136731807, 4667.183242932473, 4678.883027924295, 2917.9124626261246, 2996.8951086712077, 3013.352129292213, 3023.667396586374, 3031.3634136831292, 931.585444477208, 953.5518306395983, 965.0976337124811, 967.5549247346229, 988.4365911430488, 10416.166706663524, 10418.166546676324, 10428.79142417155, 10429.947850260776, 10446.582136714522, 4154.646855017358, 4157.397177409259, 4255.787210639455, 4288.635465985364, 4291.120320334387, 8899.243564296978, 8937.821243575092, 8959.283257339397, 8972.775680607907, 8985.955070224607, 4684.695494792828, 4690.249560070441, 4702.200625893606, 4702.200625893606, 4707.7881495332795, 3670.6145854684873, 4004.839806407711, 4078.0, 4178.91642167155, 4194.559571245037, 3448.534447849508, 3468.3756923753463, 3474.322507111089, 3494.7553671243277, 3528.7000604948353, 1157.5948418053613, 1162.8720840707515, 1165.2658824940233, 1168.4741866160261, 1191.1602320364123, 1183.331417748969, 1188.3167178872184, 1208.516593362662, 1222.7371115210271, 1237.0536539547254, 7045.612491312924, 7175.31834475724, 7221.0, 7223.566586004857, 7299.4525410594415, 413.1695292462173, 428.47725774554993, 448.03001501749003, 448.3409388199342, 448.97306161630405, 5482.2873026506295, 5507.504324610804, 5513.255710479034, 5517.668939863621, 5558.777648893999, 8730.476171429735, 9052.81894362109, 9248.075192480697, 9273.72178834636, 9360.765980850398, 9095.590698418588, 9145.176934075833, 9276.397034192756, 9281.582328795086, 9293.210077143383, 7011.228764835864, 7140.5358651687475, 7148.142222933177, 7213.747518836815, 7216.7474138404905, 6772.390484856386, 6813.4208592270215, 6820.113385259884, 6839.384455399038, 6847.281035491202, 7923.643436045277, 8126.106128325998, 8128.552929588929, 8315.958420208102, 8327.417080804285, 8250.669973201246, 8396.95801521013, 8554.957225213833, 8566.314694824523, 8573.056963734109, 6571.014347847861, 6572.8356791080605, 6676.298988606321, 6730.562513436611, 6755.054292399166, 7196.208417074223, 7198.20819709821, 7236.565806051653, 7236.638168091679, 7277.017602623578, 6457.903131453126, 6528.347165283433, 6618.106555614931, 6618.172728408949, 6817.931820681928, 6367.3314301997625, 6397.520185985976, 6593.472522198117, 6626.90059649096, 6657.167854018247, 6932.792016239319, 6968.547044442095, 6970.79087627372, 6988.091548098715, 6994.895076573754, 6194.907076393948, 6404.519661025535, 6410.1025856381075, 6420.6468644225015, 6433.646149461824, 6438.259600146043, 6458.644774537445, 6501.382368674968, 6509.414152726277, 6511.934880651323], "unit": "score", "name": "mootools.html", "value": 4227.812781167183}, {"lowerIsBetter": false, "replicates": [304.9996013077108, 305.85166194395725, 307.6738657023555, 310.58847027688313, 315.9889403870865, 5369.033573956686, 5372.22102795095, 5373.838784836456, 5424.267723857278, 5429.375621803494, 5315.867103322419, 5317.973410132953, 5329.067413202683, 5338.572914166867, 5347.278117454142, 3960.168364643414, 4039.899002524931, 4177.540470548237, 4180.289350810354, 4181.933606930229, 4176.248275310443, 4189.581041895816, 4192.308269135589, 4192.434021407102, 4193.0, 4139.234241665286, 4152.522459917103, 4154.231467178566, 4161.292580261348, 4162.937555936648, 3946.1910308386855, 4055.5944405559503, 4155.896102597429, 4179.435776170239, 4187.874363769091, 3672.6510981456986, 3673.155174309897, 3681.4661874028384, 3684.3184010958057, 3686.078480379905, 5110.744462776846, 5127.128388174019, 5130.256112863651, 5132.255822905695, 5133.153029750087, 4811.13399588074, 4815.229563269895, 4821.63837712173, 4822.156122678517, 4823.614110871122, 5597.524210442118, 5635.633683810539, 5639.68981706006, 5645.887082258373, 5647.124695672136, 4037.071473561068, 4041.7574945503366, 4044.2315959967514, 4048.109415928491, 4049.493813273341, 5740.712964351766, 5911.645301281937, 5912.054071348563, 5915.935131676297, 5918.171455996164, 4122.958770412318, 4139.048018955657, 4142.420061191436, 4142.79286035697, 4148.087420767426, 4162.41726158338, 4164.416981622575, 4197.916041679149, 4198.6011328923705, 4215.768132752728, 4751.3348131261655, 4758.310045043519, 4783.6651434399255, 4793.304970779287, 4797.352357431702, 5611.6352437091455, 5616.9608622404985, 5630.0, 5631.549476041907, 5633.126865335879, 1462.2396353895915, 1485.9257037148316, 1488.0253434000747, 1488.8287846897745, 1493.873020793223, 937.5452905340904, 985.3693636072919, 987.6543209876629, 995.2833959549113, 998.9750256243652, 4887.975560122177, 4912.164931961575, 4925.87685307863, 4942.629302802305, 4947.060058588857, 5799.043157878903, 5799.594028417971, 5805.445603934256, 5808.5933984621515, 5815.88368232633, 4928.704277743347, 4931.506849315111, 4938.901221975612, 4940.950590494121, 4941.481144479778, 3089.088718827951, 3118.4230917279924, 3122.5784519090084, 3124.42198193335, 3128.23358277219, 5453.918191227135, 5455.754491047913, 5464.808731694372, 5466.262054622575, 5472.890542189134, 5773.422657734193, 5940.881182376328, 5942.762289508371, 5944.078667806497, 5945.316288626863, 5390.4879036491475, 5416.268803711528, 5434.076207044733, 5442.782288708408, 5448.918266226089, 5818.970905145447, 5845.035569131046, 5850.268716410449, 5851.414858514115, 5852.678102704393, 5609.27079479665, 5634.859128521656, 5648.350439699487, 5649.491545760901, 5654.6889921054735, 5429.5656347492895, 5431.429699881455, 5441.483059109379, 5446.373667028342, 5448.4006759257245, 4059.5331536873637, 4160.0, 4170.35359519275, 4171.0, 4180.561041090763, 5724.627899186539, 5746.856328591819, 5761.423857614205, 5765.1928729977, 5776.826695199151, 5553.222548843246, 5555.0, 5556.694381809039, 5559.16612508127, 5559.9444005561045, 5554.861128471821, 5562.4425160955, 5563.666180029211, 5564.0, 5568.359638641446, 5477.822268212353, 5479.0411677957, 5481.971670481787, 5491.560675145899, 5495.807646732345, 5503.11950087984, 5634.774609015593, 5640.435956404491, 5690.601657883908, 5721.370649228665, 5516.724163791875, 5556.027695153251, 5572.498475137257, 5574.052411090205, 5578.581606379456], "unit": "score", "name": "prototype.html", "value": 4237.948075630499}, {"lowerIsBetter": false, "replicates": [749.056189201606, 761.6191904047975, 764.6864785437972, 775.8603451378754, 786.7364432914973, 14067.718645627081, 14375.065620734658, 14388.784168237486, 14395.64010899728, 14405.20771357575, 14119.858801411983, 14151.575452736408, 14152.150870947751, 14162.29188540574, 14219.075760075588, 656.6880731652451, 806.4475834053662, 811.2090711556215, 829.7552222094466, 831.3930830493713, 806.9354451643884, 814.8288859339546, 815.4332738746543, 817.2440492544403, 817.2685446525356, 855.0167307596283, 861.2894362151219, 863.2144748279068, 865.7229686500323, 866.5060915278294, 682.7678589279619, 838.1032295443878, 855.9443636163629, 859.3941271403645, 860.6901515454431, 616.722474886303, 618.0327787013309, 618.1469571990624, 618.153130211613, 619.4734475695623, 11847.585334513251, 11878.346690931996, 11884.940575297154, 11912.702182445422, 11936.343501107436, 11850.0, 12256.81614775779, 12368.567100151451, 12655.873441265561, 12733.74532509354, 10133.240006999431, 10142.290039697224, 10168.847467287997, 10213.591456341812, 10301.484925753683, 3247.594050743657, 3264.3308121834966, 3324.202191474029, 3395.711364534018, 3398.3882901077795, 45257.321140182925, 45346.31980520295, 45475.54524454746, 46039.76980115112, 46085.53914460846, 9740.512974351253, 9789.167920726675, 9955.651552195639, 10105.44420056904, 10109.292349535463, 17438.65122697539, 17465.0, 17485.0, 17491.825081749274, 17506.0, 6409.967950160312, 6542.705578248991, 6610.438112760469, 6614.9416093424825, 6756.0, 3790.6967442604528, 3817.656410922975, 3823.6941044716355, 3862.671672907778, 3922.6077392260545, 2768.460150270678, 2801.061644349125, 2808.199663096008, 2810.423863108058, 2812.1844665047315, 472.6431544184119, 482.6717831874289, 482.73449602718364, 489.2587729589674, 502.82903812703125, 597.1520440973827, 605.7183409714415, 607.4866737606716, 609.1624016976657, 617.0497433951664, 7938.9206107939335, 8135.959320203361, 8193.221643943816, 8205.384596155312, 8292.33661307094, 589.7965202005302, 589.9616524925866, 590.2032256453839, 594.3669991459083, 608.3612207182529, 3817.351050321452, 3897.512810898638, 3903.6486716195677, 3921.5490218625223, 4061.0, 46794.766026170335, 48024.7598762004, 49402.258966114816, 49973.75013124911, 50233.74883125561, 44096.55903440989, 44964.0, 45313.093738125055, 45487.77256113698, 45744.77127614341, 40588.18823623511, 40632.39051414231, 41010.0, 41046.1790764183, 41519.792401037805, 7660.619860089499, 7776.766696999099, 7869.6458659361615, 7987.121416644049, 8123.959380203061, 30423.54364684487, 31262.843685781427, 31352.52971205388, 31933.36133277275, 32236.19409514687, 38185.6181438182, 38879.222415552096, 38960.0, 39429.01427464221, 39981.0, 10257.076863082359, 10320.174386048948, 10399.49397098313, 10401.68794936153, 10685.893141068489, 11134.610288639858, 11244.26912250701, 11353.602623908124, 11386.715332116763, 11546.94226528862, 8405.22289015535, 11021.944890275498, 11183.888161118284, 11244.156688248579, 11810.468528916048, 10981.341119532854, 11480.655580332603, 11552.59565915189, 11585.536578536765, 11623.0, 10696.679099626712, 10730.0, 11265.042471390023, 11316.94341528287, 11349.829752553553, 9390.483523406278, 9414.858777118212, 9417.717468475958, 9626.66306679263, 9815.263855211031, 9792.216622670312, 9853.655122070693, 9888.950555247178, 9890.307678462726, 9904.851427228741], "unit": "score", "name": "yui.html", "value": 5980.067044140764}], "name": "dromaeo_css", "value": 6409.298524213144}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 109.0, 111.0, 114.0, 114.0, 102.0, 116.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [163.0, 138.0, 161.0, 169.0, 140.0, 162.0, 163.0, 132.0, 181.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 154.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 163.0, 162.0, 164.0, 165.0, 165.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 108.0, 108.0, 74.0, 74.0, 73.0, 121.0, 93.0, 77.0], "unit": "score", "name": "audio-fft", "value": 87.6}, {"lowerIsBetter": true, "replicates": [93.0, 96.0, 136.0, 94.0, 94.0, 93.0, 130.0, 94.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0, 76.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.4}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 84.0, 83.0, 82.0, 83.0, 83.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [122.0, 127.0, 118.0, 117.0, 131.0, 115.0, 116.0, 117.0, 117.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [132.0, 129.0, 150.0, 138.0, 140.0, 127.0, 141.0, 141.0, 138.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1520.5000000000002}]} 01:08:53 INFO - Return code: 0 01:08:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:08:53 ERROR - # TBPL SUCCESS # 01:08:53 INFO - Running post-action listener: _resource_record_post_action 01:08:53 INFO - Running post-run listener: _resource_record_post_run 01:08:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 491520; Write bytes: 301842432; Read time: 36; Write time: 234332 01:08:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20938752; Read time: 0; Write time: 27840 01:08:55 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 491520; Write bytes: 280903680; Read time: 36; Write time: 206492 01:08:55 INFO - Running post-run listener: _upload_blobber_files 01:08:55 INFO - Blob upload gear active. 01:08:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:08:55 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 01:08:55 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'] 01:08:55 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 01:08:55 INFO - (blobuploader) - INFO - Open directory for files ... 01:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:08:56 INFO - (blobuploader) - INFO - Done attempting. 01:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:08:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:08:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:08:57 INFO - (blobuploader) - INFO - Done attempting. 01:08:57 INFO - (blobuploader) - INFO - Iteration through files over. 01:08:57 INFO - Return code: 0 01:08:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:08:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:08:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5920aaf9a4d54d6524c5d2196c16793bf14ae42bc8b7e03e216700cacd1848c148709fb3ab5eb47c9753c39ae3dab99f893bd6202387bfc8543463130b9d7ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a85b3728354b984ffca93fb12c9a81c68877fe7f3e068ec9d5815dcb1029f47e15a564a98d19e6988f6f90d6510d8ba961dc4fb89f23ce80e5bc7a3fd9e2787"} 01:08:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:08:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:08:57 INFO - Contents: 01:08:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5920aaf9a4d54d6524c5d2196c16793bf14ae42bc8b7e03e216700cacd1848c148709fb3ab5eb47c9753c39ae3dab99f893bd6202387bfc8543463130b9d7ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a85b3728354b984ffca93fb12c9a81c68877fe7f3e068ec9d5815dcb1029f47e15a564a98d19e6988f6f90d6510d8ba961dc4fb89f23ce80e5bc7a3fd9e2787"} 01:08:57 INFO - Running post-run listener: copy_logs_to_upload_dir 01:08:57 INFO - Copying logs to upload dir... 01:08:57 INFO - mkdir: /builds/slave/test/build/upload/logs 01:08:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.453762 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-07 01:08:56.967252) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 01:08:56.970877) ========= 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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 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/5920aaf9a4d54d6524c5d2196c16793bf14ae42bc8b7e03e216700cacd1848c148709fb3ab5eb47c9753c39ae3dab99f893bd6202387bfc8543463130b9d7ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a85b3728354b984ffca93fb12c9a81c68877fe7f3e068ec9d5815dcb1029f47e15a564a98d19e6988f6f90d6510d8ba961dc4fb89f23ce80e5bc7a3fd9e2787"} build_url:https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/EowXDSeHSVyMfX2rLsMKrw/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/5920aaf9a4d54d6524c5d2196c16793bf14ae42bc8b7e03e216700cacd1848c148709fb3ab5eb47c9753c39ae3dab99f893bd6202387bfc8543463130b9d7ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a85b3728354b984ffca93fb12c9a81c68877fe7f3e068ec9d5815dcb1029f47e15a564a98d19e6988f6f90d6510d8ba961dc4fb89f23ce80e5bc7a3fd9e2787"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 01:08:57.010172) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 01:08:57.010549) ========= 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=232498196343f89f466a4a9a000001c8-1460006193.544143-1594835616 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 01:08:57.107415) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 01:08:57.107844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 01:08:57.108253) ========= ========= Total master_lag: 0.37 =========