builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1458649947.89 results: success (0) buildid: 20160322041546 builduid: 1725523878224682a1411439a0bf08f2 revision: ea6298e1b4f7e22ce2311b2b6a918822f0adb112 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:27.885565) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:27.885998) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:27.886327) ========= 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=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:27.933529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:27.933872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:27.957260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:27.957558) ========= 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=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.022196) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.022514) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.022914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.023254) ========= 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=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-22 05:32:28-- 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% 228M=0s 2016-03-22 05:32:28 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148890 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.224930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.225307) ========= 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=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017703 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.292309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.295683) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea6298e1b4f7e22ce2311b2b6a918822f0adb112 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ea6298e1b4f7e22ce2311b2b6a918822f0adb112 --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=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-22 05:32:28,493 truncating revision to first 12 chars 2016-03-22 05:32:28,493 Setting DEBUG logging. 2016-03-22 05:32:28,493 attempt 1/10 2016-03-22 05:32:28,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea6298e1b4f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 05:32:28,753 unpacking tar archive at: mozilla-central-ea6298e1b4f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531373 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.856489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.856847) ========= echo ea6298e1b4f7e22ce2311b2b6a918822f0adb112 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ea6298e1b4f7e22ce2311b2b6a918822f0adb112'] 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=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ea6298e1b4f7e22ce2311b2b6a918822f0adb112 program finished with exit code 0 elapsedTime=0.004742 script_repo_revision: 'ea6298e1b4f7e22ce2311b2b6a918822f0adb112' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.910635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.910947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 05:32:28.921328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-03-22 05:32:28.921644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:29 INFO - MultiFileLogger online at 20160322 05:32:29 in /builds/slave/test 05:32:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:32:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:29 INFO - {'append_to_log': False, 05:32:29 INFO - 'base_work_dir': '/builds/slave/test', 05:32:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:32:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:29 INFO - 'branch': 'Firefox-Non-PGO', 05:32:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:29 INFO - 'config_files': ('talos/linux_config.py',), 05:32:29 INFO - 'default_actions': ('clobber', 05:32:29 INFO - 'read-buildbot-config', 05:32:29 INFO - 'download-and-extract', 05:32:29 INFO - 'populate-webroot', 05:32:29 INFO - 'create-virtualenv', 05:32:29 INFO - 'install', 05:32:29 INFO - 'run-tests'), 05:32:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:29 INFO - 'download_minidump_stackwalk': True, 05:32:29 INFO - 'download_symbols': 'ondemand', 05:32:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:29 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:29 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:29 INFO - 'installer_path': 'installer.exe', 05:32:29 INFO - 'log_level': 'info', 05:32:29 INFO - 'log_name': 'talos', 05:32:29 INFO - 'log_to_console': True, 05:32:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:29 INFO - 'opt_config_files': (), 05:32:29 INFO - 'pip_index': False, 05:32:29 INFO - 'sps_profile': False, 05:32:29 INFO - 'sps_profile_interval': 0, 05:32:29 INFO - 'suite': 'dromaeojs', 05:32:29 INFO - 'system_bits': '32', 05:32:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:29 INFO - 'title': 'talos-linux64-ix-018', 05:32:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:29 INFO - 'use_talos_json': True, 05:32:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:29 INFO - 'work_dir': 'build'} 05:32:29 INFO - ##### 05:32:29 INFO - ##### Running clobber step. 05:32:29 INFO - ##### 05:32:29 INFO - Running pre-action listener: _resource_record_pre_action 05:32:29 INFO - Running main action method: clobber 05:32:29 INFO - rmtree: /builds/slave/test/build 05:32:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:29 INFO - Running post-action listener: _resource_record_post_action 05:32:29 INFO - ##### 05:32:29 INFO - ##### Running read-buildbot-config step. 05:32:29 INFO - ##### 05:32:29 INFO - Running pre-action listener: _resource_record_pre_action 05:32:29 INFO - Running main action method: read_buildbot_config 05:32:29 INFO - Using buildbot properties: 05:32:29 INFO - { 05:32:29 INFO - "project": "", 05:32:29 INFO - "product": "firefox", 05:32:29 INFO - "script_repo_revision": "production", 05:32:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:32:29 INFO - "repository": "", 05:32:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:32:29 INFO - "buildid": "20160322041546", 05:32:29 INFO - "pgo_build": "False", 05:32:29 INFO - "basedir": "/builds/slave/test", 05:32:29 INFO - "buildnumber": 523, 05:32:29 INFO - "slavename": "talos-linux64-ix-018", 05:32:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:32:29 INFO - "platform": "ubuntu64_hw", 05:32:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:32:29 INFO - "branch": "mozilla-central", 05:32:29 INFO - "repo_path": "mozilla-central", 05:32:29 INFO - "revision": "ea6298e1b4f7e22ce2311b2b6a918822f0adb112", 05:32:29 INFO - "stage_platform": "linux64", 05:32:29 INFO - "builduid": "1725523878224682a1411439a0bf08f2", 05:32:29 INFO - "slavebuilddir": "test" 05:32:29 INFO - } 05:32:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:32:29 INFO - Running post-action listener: _resource_record_post_action 05:32:29 INFO - ##### 05:32:29 INFO - ##### Running download-and-extract step. 05:32:29 INFO - ##### 05:32:29 INFO - Running pre-action listener: _resource_record_pre_action 05:32:29 INFO - Running main action method: download_and_extract 05:32:29 INFO - mkdir: /builds/slave/test/build/tests 05:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:29 INFO - https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:30 INFO - Downloaded 1361 bytes. 05:32:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:32:30 INFO - Using the following test package requirements: 05:32:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:32:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:32:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:30 INFO - u'jsshell-linux-x86_64.zip'], 05:32:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:32:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:32:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:32:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:32:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:32:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:32: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')]} 05:32:30 INFO - https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:32:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:32:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:31 INFO - Downloaded 22001980 bytes. 05:32:31 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'] 05:32:31 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 05:32:32 INFO - Return code: 0 05:32:32 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 05:32:32 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')]} 05:32:32 INFO - https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:46 INFO - Downloaded 22001980 bytes. 05:32:46 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'] 05:32:46 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 05:32:48 INFO - Return code: 0 05:32: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')]} 05:32:48 INFO - https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:32:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:32:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:49 INFO - Downloaded 10848120 bytes. 05:32:49 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'] 05:32:49 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 05:32:49 INFO - Return code: 0 05:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:49 INFO - https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:32:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:32:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:32:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/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 05:32:52 INFO - Downloaded 54172968 bytes. 05:32:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:32:52 INFO - mkdir: /builds/slave/test/properties 05:32:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:52 INFO - Contents: 05:32:52 INFO - build_url:https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:32:53 INFO - Running post-action listener: _resource_record_post_action 05:32:53 INFO - Running post-action listener: set_extra_try_arguments 05:32:53 INFO - ##### 05:32:53 INFO - ##### Running populate-webroot step. 05:32:53 INFO - ##### 05:32:53 INFO - Running pre-action listener: _resource_record_pre_action 05:32:53 INFO - Running main action method: populate_webroot 05:32:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:53 INFO - '--tppagecycles', 05:32:53 INFO - '7'], 05:32:53 INFO - 'tests': ['tsvgm']}}, 05:32:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:32:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:32:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:53 INFO - 'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:53 INFO - 'tests': ['damp', 'tps']}, 05:32:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:53 INFO - 'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['damp', 'tps']}, 05:32:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:32:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:53 INFO - 'other': {'tests': ['a11yr', 05:32:53 INFO - 'ts_paint', 05:32:53 INFO - 'tpaint', 05:32:53 INFO - 'sessionrestore', 05:32:53 INFO - 'sessionrestore_no_auto_restore', 05:32:53 INFO - 'tabpaint']}, 05:32:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['a11yr', 05:32:53 INFO - 'ts_paint', 05:32:53 INFO - 'tpaint', 05:32:53 INFO - 'sessionrestore', 05:32:53 INFO - 'sessionrestore_no_auto_restore', 05:32:53 INFO - 'tabpaint']}, 05:32:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['a11yr', 05:32:53 INFO - 'ts_paint', 05:32:53 INFO - 'tpaint', 05:32:53 INFO - 'sessionrestore', 05:32:53 INFO - 'sessionrestore_no_auto_restore', 05:32:53 INFO - 'tabpaint']}, 05:32:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['a11yr', 05:32:53 INFO - 'ts_paint', 05:32:53 INFO - 'tpaint', 05:32:53 INFO - 'sessionrestore', 05:32:53 INFO - 'sessionrestore_no_auto_restore', 05:32:53 INFO - 'tabpaint']}, 05:32:53 INFO - 'other_l64': {'tests': ['a11yr', 05:32:53 INFO - 'ts_paint', 05:32:53 INFO - 'tpaint', 05:32:53 INFO - 'sessionrestore', 05:32:53 INFO - 'sessionrestore_no_auto_restore', 05:32:53 INFO - 'tabpaint']}, 05:32:53 INFO - 'other_nol64': {'tests': ['a11yr', 05:32:53 INFO - 'ts_paint', 05:32:53 INFO - 'tpaint', 05:32:53 INFO - 'sessionrestore', 05:32:53 INFO - 'sessionrestore_no_auto_restore', 05:32:53 INFO - 'tabpaint']}, 05:32:53 INFO - 'svgr': {'tests': ['tsvgx', 05:32:53 INFO - 'tsvgr_opacity', 05:32:53 INFO - 'tart', 05:32:53 INFO - 'tscrollx', 05:32:53 INFO - 'cart']}, 05:32:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['tsvgx', 05:32:53 INFO - 'tsvgr_opacity', 05:32:53 INFO - 'tart', 05:32:53 INFO - 'tscrollx', 05:32:53 INFO - 'cart']}, 05:32:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:53 INFO - 'tests': ['tp5o']}, 05:32:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:53 INFO - 'talos_options': ['--e10s'], 05:32:53 INFO - 'tests': ['tp5o']}, 05:32:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:53 INFO - 'talos_options': ['--xperf_path', 05:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:53 INFO - 'tests': ['tp5n']}, 05:32:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:53 INFO - 'talos_options': ['--e10s', 05:32:53 INFO - '--xperf_path', 05:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:53 INFO - 'tests': ['tp5n']}}, 05:32:53 INFO - 'talos.zip': {'path': '', 05:32:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:53 INFO - Running post-action listener: _resource_record_post_action 05:32:53 INFO - ##### 05:32:53 INFO - ##### Running create-virtualenv step. 05:32:53 INFO - ##### 05:32:53 INFO - Running pre-action listener: _resource_record_pre_action 05:32:53 INFO - Running main action method: create_virtualenv 05:32:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:53 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 05:32:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:53 INFO - Using real prefix '/usr' 05:32:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:56 INFO - Installing pip.................done. 05:32:56 INFO - Return code: 0 05:32:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:56 INFO - Using env: {'DISPLAY': ':0', 05:32:56 INFO - 'HOME': '/home/cltbld', 05:32:56 INFO - 'LANG': 'en_US.UTF-8', 05:32:56 INFO - 'LANGUAGE': 'en_US:en', 05:32:56 INFO - 'LOGNAME': 'cltbld', 05:32:56 INFO - 'MAIL': '/var/mail/cltbld', 05:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:56 INFO - 'MOZ_NO_REMOTE': '1', 05:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:56 INFO - 'NO_EM_RESTART': '1', 05:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:56 INFO - 'PWD': '/builds/slave/test', 05:32:56 INFO - 'SHELL': '/bin/bash', 05:32:56 INFO - 'SHLVL': '1', 05:32:56 INFO - 'TERM': 'linux', 05:32:56 INFO - 'TMOUT': '86400', 05:32:56 INFO - 'USER': 'cltbld', 05:32:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:56 INFO - '_': '/tools/buildbot/bin/python'} 05:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:56 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 05:32:56 INFO - Cleaning up... 05:32:56 INFO - Return code: 0 05:32:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:32:56 INFO - Using env: {'DISPLAY': ':0', 05:32:56 INFO - 'HOME': '/home/cltbld', 05:32:56 INFO - 'LANG': 'en_US.UTF-8', 05:32:56 INFO - 'LANGUAGE': 'en_US:en', 05:32:56 INFO - 'LOGNAME': 'cltbld', 05:32:56 INFO - 'MAIL': '/var/mail/cltbld', 05:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:56 INFO - 'MOZ_NO_REMOTE': '1', 05:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:56 INFO - 'NO_EM_RESTART': '1', 05:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:56 INFO - 'PWD': '/builds/slave/test', 05:32:56 INFO - 'SHELL': '/bin/bash', 05:32:56 INFO - 'SHLVL': '1', 05:32:56 INFO - 'TERM': 'linux', 05:32:56 INFO - 'TMOUT': '86400', 05:32:56 INFO - 'USER': 'cltbld', 05:32:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:56 INFO - '_': '/tools/buildbot/bin/python'} 05:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:56 INFO - Downloading/unpacking psutil>=0.7.1 05:32: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 05:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32: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 05:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:58 INFO - Installing collected packages: psutil 05:32:58 INFO - Running setup.py install for psutil 05:32:58 INFO - building 'psutil._psutil_linux' extension 05:32:58 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 05:32:58 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 05:32:58 INFO - building 'psutil._psutil_posix' extension 05:32:58 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 05:32:58 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 05:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:59 INFO - Successfully installed psutil 05:32:59 INFO - Cleaning up... 05:32:59 INFO - Return code: 0 05:32:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:32:59 INFO - Using env: {'DISPLAY': ':0', 05:32:59 INFO - 'HOME': '/home/cltbld', 05:32:59 INFO - 'LANG': 'en_US.UTF-8', 05:32:59 INFO - 'LANGUAGE': 'en_US:en', 05:32:59 INFO - 'LOGNAME': 'cltbld', 05:32:59 INFO - 'MAIL': '/var/mail/cltbld', 05:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:59 INFO - 'MOZ_NO_REMOTE': '1', 05:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:59 INFO - 'NO_EM_RESTART': '1', 05:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:59 INFO - 'PWD': '/builds/slave/test', 05:32:59 INFO - 'SHELL': '/bin/bash', 05:32:59 INFO - 'SHLVL': '1', 05:32:59 INFO - 'TERM': 'linux', 05:32:59 INFO - 'TMOUT': '86400', 05:32:59 INFO - 'USER': 'cltbld', 05:32:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:59 INFO - '_': '/tools/buildbot/bin/python'} 05:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:33:01 INFO - Installing collected packages: mozsystemmonitor 05:33:01 INFO - Running setup.py install for mozsystemmonitor 05:33:01 INFO - Successfully installed mozsystemmonitor 05:33:01 INFO - Cleaning up... 05:33:01 INFO - Return code: 0 05:33:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:33:01 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 05:33:01 INFO - Using env: {'DISPLAY': ':0', 05:33:01 INFO - 'HOME': '/home/cltbld', 05:33:01 INFO - 'LANG': 'en_US.UTF-8', 05:33:01 INFO - 'LANGUAGE': 'en_US:en', 05:33:01 INFO - 'LOGNAME': 'cltbld', 05:33:01 INFO - 'MAIL': '/var/mail/cltbld', 05:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:01 INFO - 'MOZ_NO_REMOTE': '1', 05:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:01 INFO - 'NO_EM_RESTART': '1', 05:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:01 INFO - 'PWD': '/builds/slave/test', 05:33:01 INFO - 'SHELL': '/bin/bash', 05:33:01 INFO - 'SHLVL': '1', 05:33:01 INFO - 'TERM': 'linux', 05:33:01 INFO - 'TMOUT': '86400', 05:33:01 INFO - 'USER': 'cltbld', 05:33:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:01 INFO - '_': '/tools/buildbot/bin/python'} 05:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:01 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:01 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 05:33:01 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 05:33:01 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 05:33:01 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 05:33:01 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 05:33:01 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 05:33:03 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:03 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 05:33:03 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 05:33:03 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 05:33:03 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 05:33:03 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 05:33:03 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 05:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:04 INFO - Downloading docopt-0.6.1.tar.gz 05:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:04 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:04 INFO - Running setup.py install for blobuploader 05:33:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:04 INFO - Running setup.py install for requests 05:33:04 INFO - Running setup.py install for docopt 05:33:04 INFO - Successfully installed blobuploader requests docopt 05:33:04 INFO - Cleaning up... 05:33:05 INFO - Return code: 0 05:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 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 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:33:05 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 05:33:05 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 05:33:05 INFO - Using env: {'DISPLAY': ':0', 05:33:05 INFO - 'HOME': '/home/cltbld', 05:33:05 INFO - 'LANG': 'en_US.UTF-8', 05:33:05 INFO - 'LANGUAGE': 'en_US:en', 05:33:05 INFO - 'LOGNAME': 'cltbld', 05:33:05 INFO - 'MAIL': '/var/mail/cltbld', 05:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:05 INFO - 'MOZ_NO_REMOTE': '1', 05:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:05 INFO - 'NO_EM_RESTART': '1', 05:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:05 INFO - 'PWD': '/builds/slave/test', 05:33:05 INFO - 'SHELL': '/bin/bash', 05:33:05 INFO - 'SHLVL': '1', 05:33:05 INFO - 'TERM': 'linux', 05:33:05 INFO - 'TMOUT': '86400', 05:33:05 INFO - 'USER': 'cltbld', 05:33:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:05 INFO - '_': '/tools/buildbot/bin/python'} 05:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:05 INFO - Running setup.py (path:/tmp/pip-eSMj_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:05 INFO - Running setup.py (path:/tmp/pip-fb_vhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:05 INFO - Running setup.py (path:/tmp/pip-qHurG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:05 INFO - Running setup.py (path:/tmp/pip-q4L9xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:05 INFO - Running setup.py (path:/tmp/pip-D8jKKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:05 INFO - Running setup.py (path:/tmp/pip-vNi1uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:05 INFO - Running setup.py (path:/tmp/pip-7_V3jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:05 INFO - Running setup.py (path:/tmp/pip-ZWp0Yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:05 INFO - Running setup.py (path:/tmp/pip-jdDFOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:05 INFO - Running setup.py (path:/tmp/pip-uc8TkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:05 INFO - Running setup.py (path:/tmp/pip-BeAEld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:06 INFO - Running setup.py (path:/tmp/pip-JfS1St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:06 INFO - Running setup.py (path:/tmp/pip-42PRXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:06 INFO - Running setup.py (path:/tmp/pip-NE9gKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:06 INFO - Running setup.py (path:/tmp/pip-P3oBI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:06 INFO - Running setup.py (path:/tmp/pip-q76vgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:06 INFO - Running setup.py (path:/tmp/pip-niiUjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:06 INFO - Running setup.py install for manifestparser 05:33:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:06 INFO - Running setup.py install for mozcrash 05:33:06 INFO - Running setup.py install for mozdebug 05:33:06 INFO - Running setup.py install for mozdevice 05:33:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:06 INFO - Running setup.py install for mozfile 05:33:06 INFO - Running setup.py install for mozhttpd 05:33:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Running setup.py install for mozinfo 05:33:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Running setup.py install for mozInstall 05:33:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Running setup.py install for mozleak 05:33:07 INFO - Running setup.py install for mozlog 05:33:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Running setup.py install for moznetwork 05:33:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Running setup.py install for mozprocess 05:33:07 INFO - Running setup.py install for mozprofile 05:33:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Running setup.py install for mozrunner 05:33:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:07 INFO - Running setup.py install for mozscreenshot 05:33:07 INFO - Running setup.py install for moztest 05:33:08 INFO - Running setup.py install for mozversion 05:33:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:08 INFO - Cleaning up... 05:33:08 INFO - Return code: 0 05:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:08 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')]} 05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:08 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')]} 05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:08 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 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:33:08 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 05:33:08 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 05:33:08 INFO - Using env: {'DISPLAY': ':0', 05:33:08 INFO - 'HOME': '/home/cltbld', 05:33:08 INFO - 'LANG': 'en_US.UTF-8', 05:33:08 INFO - 'LANGUAGE': 'en_US:en', 05:33:08 INFO - 'LOGNAME': 'cltbld', 05:33:08 INFO - 'MAIL': '/var/mail/cltbld', 05:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:08 INFO - 'MOZ_NO_REMOTE': '1', 05:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:08 INFO - 'NO_EM_RESTART': '1', 05:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:08 INFO - 'PWD': '/builds/slave/test', 05:33:08 INFO - 'SHELL': '/bin/bash', 05:33:08 INFO - 'SHLVL': '1', 05:33:08 INFO - 'TERM': 'linux', 05:33:08 INFO - 'TMOUT': '86400', 05:33:08 INFO - 'USER': 'cltbld', 05:33:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:08 INFO - '_': '/tools/buildbot/bin/python'} 05:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:08 INFO - Running setup.py (path:/tmp/pip-bwYrIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:08 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)) 05:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:08 INFO - Running setup.py (path:/tmp/pip-4ZqXnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:08 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)) 05:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:08 INFO - Running setup.py (path:/tmp/pip-F66EID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:08 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)) 05:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:08 INFO - Running setup.py (path:/tmp/pip-8CfVdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:08 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)) 05:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:08 INFO - Running setup.py (path:/tmp/pip-Fb42g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:08 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)) 05:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:08 INFO - Running setup.py (path:/tmp/pip-JIt1Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:08 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)) 05:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:08 INFO - Running setup.py (path:/tmp/pip-gAyiBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:08 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)) 05:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:08 INFO - Running setup.py (path:/tmp/pip-eYYlhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:09 INFO - Running setup.py (path:/tmp/pip-bgd1mK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:09 INFO - Running setup.py (path:/tmp/pip-tbkwEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:09 INFO - Running setup.py (path:/tmp/pip-un1Yna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:09 INFO - Running setup.py (path:/tmp/pip-gy_ELn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:09 INFO - Running setup.py (path:/tmp/pip-wao5se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:09 INFO - Running setup.py (path:/tmp/pip-4BIxXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:09 INFO - Running setup.py (path:/tmp/pip-sPoklp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:09 INFO - Running setup.py (path:/tmp/pip-xZjaVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:09 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)) 05:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:09 INFO - Running setup.py (path:/tmp/pip-LekXdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:09 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)) 05:33:09 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)) 05:33:09 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)) 05:33:09 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)) 05:33:09 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)) 05:33:09 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)) 05:33:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:12 INFO - Downloading blessings-1.6.tar.gz 05:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:12 INFO - Installing collected packages: blessings 05:33:12 INFO - Running setup.py install for blessings 05:33:12 INFO - Successfully installed blessings 05:33:12 INFO - Cleaning up... 05:33:12 INFO - Return code: 0 05:33:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:12 INFO - Reading from file tmpfile_stdout 05:33:12 INFO - Current package versions: 05:33:12 INFO - argparse == 1.2.1 05:33:12 INFO - blessings == 1.6 05:33:12 INFO - blobuploader == 1.2.4 05:33:12 INFO - docopt == 0.6.1 05:33:12 INFO - manifestparser == 1.1 05:33:12 INFO - mozInstall == 1.12 05:33:12 INFO - mozcrash == 0.17 05:33:12 INFO - mozdebug == 0.1 05:33:12 INFO - mozdevice == 0.48 05:33:12 INFO - mozfile == 1.2 05:33:12 INFO - mozhttpd == 0.7 05:33:12 INFO - mozinfo == 0.9 05:33:12 INFO - mozleak == 0.1 05:33:12 INFO - mozlog == 3.1 05:33:12 INFO - moznetwork == 0.27 05:33:12 INFO - mozprocess == 0.22 05:33:12 INFO - mozprofile == 0.28 05:33:12 INFO - mozrunner == 6.11 05:33:12 INFO - mozscreenshot == 0.1 05:33:12 INFO - mozsystemmonitor == 0.0 05:33:12 INFO - moztest == 0.7 05:33:12 INFO - mozversion == 1.4 05:33:12 INFO - psutil == 3.1.1 05:33:12 INFO - requests == 1.2.3 05:33:12 INFO - wsgiref == 0.1.2 05:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:12 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')]} 05:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:12 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')]} 05:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:12 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 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:33:12 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 05:33:12 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 05:33:12 INFO - Using env: {'DISPLAY': ':0', 05:33:12 INFO - 'HOME': '/home/cltbld', 05:33:12 INFO - 'LANG': 'en_US.UTF-8', 05:33:12 INFO - 'LANGUAGE': 'en_US:en', 05:33:12 INFO - 'LOGNAME': 'cltbld', 05:33:12 INFO - 'MAIL': '/var/mail/cltbld', 05:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:12 INFO - 'MOZ_NO_REMOTE': '1', 05:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:12 INFO - 'NO_EM_RESTART': '1', 05:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:12 INFO - 'PWD': '/builds/slave/test', 05:33:12 INFO - 'SHELL': '/bin/bash', 05:33:12 INFO - 'SHLVL': '1', 05:33:12 INFO - 'TERM': 'linux', 05:33:12 INFO - 'TMOUT': '86400', 05:33:12 INFO - 'USER': 'cltbld', 05:33:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:12 INFO - '_': '/tools/buildbot/bin/python'} 05:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 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)) 05:33:12 INFO - Cleaning up... 05:33:12 INFO - Return code: 0 05:33:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:12 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')]} 05:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:12 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')]} 05:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:12 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 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:33:12 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 05:33:12 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 05:33:12 INFO - Using env: {'DISPLAY': ':0', 05:33:12 INFO - 'HOME': '/home/cltbld', 05:33:12 INFO - 'LANG': 'en_US.UTF-8', 05:33:12 INFO - 'LANGUAGE': 'en_US:en', 05:33:12 INFO - 'LOGNAME': 'cltbld', 05:33:12 INFO - 'MAIL': '/var/mail/cltbld', 05:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:12 INFO - 'MOZ_NO_REMOTE': '1', 05:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:12 INFO - 'NO_EM_RESTART': '1', 05:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:12 INFO - 'PWD': '/builds/slave/test', 05:33:12 INFO - 'SHELL': '/bin/bash', 05:33:12 INFO - 'SHLVL': '1', 05:33:12 INFO - 'TERM': 'linux', 05:33:12 INFO - 'TMOUT': '86400', 05:33:12 INFO - 'USER': 'cltbld', 05:33:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:12 INFO - '_': '/tools/buildbot/bin/python'} 05:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:12 INFO - Downloading/unpacking jsonschema 05:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:14 INFO - Downloading/unpacking functools32 (from jsonschema) 05:33:14 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 05:33:14 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 05:33:14 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 05:33:14 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 05:33:14 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 05:33:14 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 05:33:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:15 INFO - warning: no files found matching '*.txt' 05:33:15 INFO - no previously-included directories found matching 'build' 05:33:15 INFO - no previously-included directories found matching 'dist' 05:33:15 INFO - no previously-included directories found matching '.git*' 05:33:15 INFO - Installing collected packages: jsonschema, functools32 05:33:15 INFO - Running setup.py install for functools32 05:33:15 INFO - warning: no files found matching '*.txt' 05:33:15 INFO - no previously-included directories found matching 'build' 05:33:15 INFO - no previously-included directories found matching 'dist' 05:33:15 INFO - no previously-included directories found matching '.git*' 05:33:15 INFO - Successfully installed jsonschema functools32 05:33:15 INFO - Cleaning up... 05:33:15 INFO - Return code: 0 05:33:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:15 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 0x7fb646dc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', '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 05:33:15 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 05:33:15 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 05:33:15 INFO - Using env: {'DISPLAY': ':0', 05:33:15 INFO - 'HOME': '/home/cltbld', 05:33:15 INFO - 'LANG': 'en_US.UTF-8', 05:33:15 INFO - 'LANGUAGE': 'en_US:en', 05:33:15 INFO - 'LOGNAME': 'cltbld', 05:33:15 INFO - 'MAIL': '/var/mail/cltbld', 05:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:15 INFO - 'MOZ_NO_REMOTE': '1', 05:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:15 INFO - 'NO_EM_RESTART': '1', 05:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:15 INFO - 'PWD': '/builds/slave/test', 05:33:15 INFO - 'SHELL': '/bin/bash', 05:33:15 INFO - 'SHLVL': '1', 05:33:15 INFO - 'TERM': 'linux', 05:33:15 INFO - 'TMOUT': '86400', 05:33:15 INFO - 'USER': 'cltbld', 05:33:15 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:15 INFO - '_': '/tools/buildbot/bin/python'} 05:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:15 INFO - Downloading/unpacking flake8 05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:33:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:33:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:33:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:18 INFO - no previously-included directories found matching 'docs/_build' 05:33:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:33:18 INFO - Running setup.py install for pep8 05:33:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:18 INFO - no previously-included directories found matching 'docs/_build' 05:33:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:33:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:33:18 INFO - Cleaning up... 05:33:19 INFO - Return code: 0 05:33:19 INFO - Running post-action listener: _resource_record_post_action 05:33:19 INFO - Running post-action listener: _start_resource_monitoring 05:33:19 INFO - Starting resource monitoring. 05:33:19 INFO - ##### 05:33:19 INFO - ##### Running install step. 05:33:19 INFO - ##### 05:33:19 INFO - Running pre-action listener: _resource_record_pre_action 05:33:19 INFO - Running main action method: install 05:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:19 INFO - Reading from file tmpfile_stdout 05:33:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:19 INFO - Reading from file tmpfile_stdout 05:33:19 INFO - Output received: 05:33:19 INFO - Usage: mozinstall [options] installer 05:33:19 INFO - Options: 05:33:19 INFO - -h, --help show this help message and exit 05:33:19 INFO - -d DEST, --destination=DEST 05:33:19 INFO - Directory to install application into. [default: 05:33:19 INFO - "/builds/slave/test"] 05:33:19 INFO - --app=APP Application being installed. [default: firefox] 05:33:19 INFO - mkdir: /builds/slave/test/build/application 05:33:19 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'] 05:33:19 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 05:33:35 INFO - Reading from file tmpfile_stdout 05:33:35 INFO - Output received: 05:33:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:33:35 INFO - Running post-action listener: _resource_record_post_action 05:33:35 INFO - ##### 05:33:35 INFO - ##### Running run-tests step. 05:33:35 INFO - ##### 05:33:35 INFO - Running pre-action listener: _resource_record_pre_action 05:33:35 INFO - Running main action method: run_tests 05:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:35 INFO - Python 2.7.3 05:33:35 INFO - Return code: 0 05:33:35 INFO - grabbing minidump binary from tooltool 05:33: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')]} 05:33:35 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 0x2d0c410>, '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 0x2d0d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d0d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:35 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 05:33:35 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 05:33:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:35 INFO - Return code: 0 05:33:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:33:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:33:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:33:36 INFO - Return code: 0 05:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 05:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 05:33:36 INFO - Using env: {'DISPLAY': ':0', 05:33:36 INFO - 'HOME': '/home/cltbld', 05:33:36 INFO - 'LANG': 'en_US.UTF-8', 05:33:36 INFO - 'LANGUAGE': 'en_US:en', 05:33:36 INFO - 'LOGNAME': 'cltbld', 05:33:36 INFO - 'MAIL': '/var/mail/cltbld', 05:33:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:36 INFO - 'MOZ_NO_REMOTE': '1', 05:33:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:36 INFO - 'NO_EM_RESTART': '1', 05:33:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:36 INFO - 'PWD': '/builds/slave/test', 05:33:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:36 INFO - 'SHELL': '/bin/bash', 05:33:36 INFO - 'SHLVL': '1', 05:33:36 INFO - 'TERM': 'linux', 05:33:36 INFO - 'TMOUT': '86400', 05:33:36 INFO - 'USER': 'cltbld', 05:33:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818', 05:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:36 INFO - '_': '/tools/buildbot/bin/python'} 05:33:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 05:33:36 INFO - mozversion application_buildid: 20160322041546 05:33:36 INFO - mozversion application_changeset: ea6298e1b4f7e22ce2311b2b6a918822f0adb112 05:33:36 INFO - mozversion application_display_name: Nightly 05:33:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:36 INFO - mozversion application_name: Firefox 05:33:36 INFO - mozversion application_remotingname: firefox 05:33:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:36 INFO - mozversion application_vendor: Mozilla 05:33:36 INFO - mozversion application_version: 48.0a1 05:33:36 INFO - mozversion platform_buildid: 20160322041546 05:33:36 INFO - mozversion platform_changeset: ea6298e1b4f7e22ce2311b2b6a918822f0adb112 05:33:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:36 INFO - mozversion platform_version: 48.0a1 05:33:36 INFO - using testdate: 1458650016 05:33:36 INFO - actual date: 1458650016 05:33:36 INFO - starting webserver on 'localhost:37419' 05:33:36 INFO - SUITE-START | Running 2 tests 05:33:36 INFO - TEST-START | dromaeo_css 05:33:36 INFO - operating with platform_type : linux_ 05:33:36 INFO - Initialising browser for dromaeo_css test... 05:33:36 INFO - TEST-INFO | started process 29331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYVKDb/profile http://localhost:37419/getInfo.html) 05:33:40 INFO - PROCESS | 29331 | __metrics Screen width/height:1600/1200 05:33:40 INFO - PROCESS | 29331 | colorDepth:24 05:33:40 INFO - PROCESS | 29331 | Browser inner width/height: 1024/697 05:33:40 INFO - PROCESS | 29331 | __metrics 05:33:41 ERROR - PROCESS | 29331 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:33:42 INFO - TEST-INFO | 29331: exit 0 05:33:42 INFO - Browser initialized. 05:33:42 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:42 INFO - TEST-INFO | started process 29424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYVKDb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:54 INFO - PROCESS | 29424 | RSS: Main: 157724672 05:33:54 INFO - PROCESS | 29424 | 05:34:45 INFO - PROCESS | 29424 | 1458650085238 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] 05:36:56 INFO - PROCESS | 29424 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37419/tests/dromaeo/cssquery-ext.html) 05:36:57 INFO - PROCESS | 29424 | RSS: Main: 246476800 05:36:57 INFO - PROCESS | 29424 | 05:39:59 INFO - PROCESS | 29424 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-ext.html (next: http://localhost:37419/tests/dromaeo/cssquery-jquery.html) 05:39:59 INFO - PROCESS | 29424 | RSS: Main: 241627136 05:39:59 INFO - PROCESS | 29424 | 05:43:01 INFO - PROCESS | 29424 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37419/tests/dromaeo/cssquery-mootools.html) 05:43:02 INFO - PROCESS | 29424 | RSS: Main: 241537024 05:43:02 INFO - PROCESS | 29424 | 05:46:04 INFO - PROCESS | 29424 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37419/tests/dromaeo/cssquery-prototype.html) 05:46:04 INFO - PROCESS | 29424 | RSS: Main: 200511488 05:46:04 INFO - PROCESS | 29424 | 05:49:07 INFO - PROCESS | 29424 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37419/tests/dromaeo/cssquery-yui.html) 05:49:08 INFO - PROCESS | 29424 | RSS: Main: 202686464 05:49:08 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-yui.html (next: http://localhost:37419/tests/dromaeo/cssquery-dojo.html) 05:52:10 INFO - PROCESS | 29424 | RSS: Main: 274911232 05:52:10 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | __start_tp_report 05:52:10 INFO - PROCESS | 29424 | _x_x_mozilla_page_load 05:52:10 INFO - PROCESS | 29424 | _x_x_mozilla_page_load_details 05:52:10 INFO - PROCESS | 29424 | |i|pagename|runs| 05:52:10 INFO - PROCESS | 29424 | |0;dojo.html;2598.597217431298;2628.8291261068016;2691.34062154772;2693.299742067063;2703.229579569823;4454.109178164372;4487.730736155833;4631.16639004979;4642.6982246153975;4699.859004229875;4605.355250264965;4624.907501849961;4635.907281854369;4663.930041049379;4693.366395536602;4200.222958752625;4308.612224899758;4341.522432532419;4402.185595664812;4435.090806384699;4157.147784704143;4299.828006879721;4370.868873933771;4382.583654552813;4397.714148580348;4231.788410579474;4258.361245813122;4318.395424640553;4349.69552131351;4369.519352871182;4285.5071666758095;4306.44016277885;4309.676774241944;4343.066240758252;4346.956530434687;4149.3775933609895;4288.635465985364;4298.226319262531;4310.267254566731;4352.064306174156;4502.57225563571;4540.228161212602;4568.474625418086;4600.5629465200755;4603.309503574457;4903.289023091632;4931.482194369575;4932.80268789248;4938.777755001033;4979.053979743837;4762.452317983407;4925.729084900329;4941.579965702919;4947.134251506008;4984.6261530385;4597.471290801601;4599.08018396322;4604.723716577016;4610.331501932201;4641.559051890065;4982.526659967298;4984.526469985346;4987.850364489072;5010.649254552146;5029;4683.625309975194;4774.355462012653;4788.186008378584;4839.443464001685;4949.381327334083;4838.129136755418;4858.05267972749;4861.222204447342;4902.828401005948;4927.43334516528;4813.638977076734;4815.686980346266;4828.203346447867;4833.685810422311;4871.853844384674;4718.646101542398;4824.131656301899;4890.2909078184175;4956.430010548833;4993.875153121201;4113.444684967491;4116.9794151029655;4120.443740095049;4123.154753275571;4151.99999999994;3637.0361854108683;3640.8179591020344;3652.817359132086;3659.9451008234896;3677.2093999790172;4191.664666826647;4252.808623611945;4260.978695106504;4299;4301.483821941387;4951.579115775199;4957.7769000395065;4961.578265847371;4988.176950803149;5035.043341765053;4300.161468513672;4309.676774241944;4309.806058727365;4313.503947046067;4347.3044312910415;4287.978560107242;4366.541513141138;4459.643228541709;4480.507144214133;4505;4651.1162879053545;4689.765511724332;4690.0150968295675;4693.6949098308505;4712.269598212282;4816.229403295456;4990.750462476934;4991.226359914219;4993.27597498368;5043.722595257296;4644.071185762793;4681.672282940298;4684.5549672781035;4711.9764401179145;4735.526447355374;4919.606431485401;4943.060818444484;4964.404271487445;4968.552830245295;5021.372328458942;4791.137595232753;4905.2151655734915;5021.096202683552;5043.747812609281;5089.033083714231;4825;4827.058723549015;4849.2968519565175;4854.126257273583;4903.656744027884;4817.710937343771;4818.156822555969;4823.710577365369;4830.879228019187;4833.492483289204;4573.268277075652;4714.457837348748;4761.16679581065;4797.664163508661;4835.8065677372515;4750.429948406213;4767.880802979815;4774.116788394158;4811.49479304682;4832.975835120802;4671.205894997791;4671.929921051119;4673.252279635242;4697.271922851964;4720.716756994591 05:52:10 INFO - PROCESS | 29424 | |1;ext.html;522.7203446156304;536.8228484600082;540.0441219042298;542.121762744354;555.3752028967411;24864.005439782388;25316.87341563292;36087.81956090219;36383.454248186295;36403.089922751875;38938.610613893856;39504.40743388851;39604.80197599015;39607.60392396075;39636.99999999993;7707.884381734279;7865.056193256817;7900.960495197544;7901.683932642687;7904.407169462284;7639.274268944441;7746.651400686983;7747.2640099190485;7785.805354866117;7795.1035630902325;7701.075870895473;7823.5305881647;7993.200679932019;7996.520208787462;7997;7864.68541258349;7944.801379965489;7967.203279672044;7968.920310796876;7969.442139050268;7882.80292992674;8028.036635603765;8038.919610803934;8042.597870106471;8045.517268963881;38789;39254;39442.802785986176;39469.60530394688;39471.802640986614;3092.78350515464;3182.6499085100622;3223.3231021485517;3330.6835850594157;3371.6322308899985;28319.904506117495;29758.553621695693;29807.10578682643;29872.850635746898;30592.847035764902;3408.9147771305916;3524.207053412987;3526.84129214186;3576.982115089434;3609.1157666371905;243316;244123.77938110373;244462;245101;245879;56523.15215271774;56650.716746416;56783;56831.715841421355;56841.71579142078;64695.35304646893;65157.34842651607;65738;65770.67114664492;65784;12737.108402411928;12866.549670761478;12887.226766394046;12903.870961290268;12915.741685166431;9401.529923503798;9434.433933963985;9438.48088355147;9438.858417123749;9441.875577994897;19730.112144953513;20070.297539586045;20178.697319540217;20248.873868243918;21119.577608448053;7509.286617771303;8015.839683206304;8044.597770111471;8051.63767630458;8060.919390806017;898.2993265253114;923.1922068190333;1048.0829274384914;1055.5830446973403;1056.265895202842;27446.5883011755;27631.171064868086;27657.170284891487;27887.302817429725;28147.577786333222;908.7637214324191;1012.2863381316155;1046.3617193511952;1047.3872784421046;1119.3955264157428;13169.736605268032;13199.53801616958;13325.466981320833;13383.933080334731;13435.865641343657;349516;353424;354493;354905;355449;41868.79065604713;42688.57311426846;42735;42752.57247427548;42854.78572607117;1131.8189089745765;1160.3791971295316;1234.8394708687813;1261.375619068567;1267.4866678994838;24741.381465463506;26464.8676756615;26800.865995669898;26846.865765671046;26858.865705671345;37741;38464.423033655075;38523;38551.807240963615;39279;217373;218070;218349;218435;218727;31537.36925261436;33150.171245718084;33156.66843331536;33179.336413271114;33230;35177.82411087928;35267.82366088256;36108.09729756777;36164.63835361613;36170.09574760547;35224.82387588046;35875.82062089777;36354.4546831803;36492;36545.26909461849;35065.824670876485;35605.82197088998;35677.82161089178;35752;35868.461973069905;34274.31451370909;34951;35086.64913350834;35102.29795404027;35328.29343413169;30244.24389390283;31742.52386214255;32217.677823221467;32290.192745181557;32412.675873240965;24275.878620606785;24444.388890277172;24827.50344993054;25016.124435644666;25073.87463062673 05:52:10 INFO - PROCESS | 29424 | |2;jquery.html;351.7098393825095;354.43467669067826;356.88758041217017;357.29256072975505;357.97975769058206;15411.537653870373;15964.361425542978;15977.201139943;16667.24997375118;16722.08028558429;10192.541335639895;10511.211659125558;12056.638300850967;15343.3095510702;15360.462383816568;4548.7270763754195;4680.204365257898;4683.2038553446;4688.718676879381;4699.929501057487;3437.6218615952225;4267.914641707164;5981.312149102843;5987.401259874021;5990.580659353847;5732.054211055191;5963.55273354498;5978.461938425541;5979.5515336349945;6005.969970150143;3376.9493457598155;4979.626528010395;5180.093483640348;5185.429602743714;5945.613535120225;4836.41962964443;5043.571296439807;5046.1169295373165;5050.065737838511;5052.292679024939;18004.369847055423;18308;18851.43445696631;19907;19910.701339479918;1919.4145785535407;1925.951851203717;1954.0913475233942;2005.5788284460282;2052.5279185787354;8891.510966896818;8915.955420222923;8980.55097245135;9279.67521136757;9326.673566425143;1765.1968354398846;1782.5721826761614;1805.2959345855127;1831.9633607327912;1868.8972106534136;58682;58815.41184588142;59645.7017714913;60475.09287360693;61238;10239.692809215736;10240.743981400525;10244.282900196915;10334.328268662513;10423.322484038514;13149.53976610814;13190.868091318964;13220.801687974688;13232.933835330954;13241.337933103307;6476.255230648441;6558.147440832661;6640.203175618956;6745.763898263537;6754.425873800684;6085.726142323606;6165.229346331708;6268.529860260499;6268.749250029948;6273.059041143773;4316.956830431718;4340.934885976713;4359.607635312774;4415.933760993587;4418.734875907456;1669.4323929863904;1778.6709458750172;1791.973120403195;1806.2504060814877;1808.493621785902;875.3741075131312;889.4752096263236;902.1880307723102;909;948.9656274660515;15533.378664853279;15730.606734831492;15829.68340633181;15970.520884373487;16339.428120015742;882.8146089321186;913.9268858491305;942.3874481587023;954.9474778887228;973.2846357926918;8932.240759535382;9133.086691330947;9180.678676246433;9243.306751993627;9355.90644093564;361085;377668;377676;388089;389881;65501;67068;68290.65854670794;69929.65035174893;69999.65000174966;897.7665806890255;901.9774505637412;914.7072936660338;915.1306259053925;944.0370821761902;14029.508967186099;14354.856451435351;14383.20892350889;14397.568072957829;14436;31977;32292.515612266303;32550.674493255712;32577.837110815242;32663.173510621673;44445.77777111094;45582.31626525671;45794.542054579026;45842.77078614719;46277.537224627325;6771.548550162183;6787.185537735306;6900.758473453405;6902.965485172542;7027.789166325018;8318.085010648945;10256;10886.727831803952;11223.326600403676;11379.146564007568;9274.721758347261;9319.767005824908;9660.71017869465;9883.50582470888;10050.296479246383;9462.526873656152;9567.282453816131;9623.470709111067;9760.56077476501;10089.29374943747;5388.811391601275;8524.27543658796;8529.701460448854;9903.702888913343;10114.140298074746;7252.202257751748;7329.9267007329245;7407.703691852265;7492.063492063492;7526.698932042657;8380.58097095155;9920.553575088994;10230;10342.482875856327;10546.78906421852 05:52:10 INFO - PROCESS | 29424 | |3;mootools.html;1161.3612513117782;1169.894709476147;1244.2721008210199;1304.726007538417;1396.6648004478927;6988.895166572499;7150.606716630589;7162.820929476772;7164.391026762718;7184.425245980322;7089.18474375447;7270.636468176584;7280.235575264601;7283.708651653941;7284.599347035924;1889.962200755984;1946.3771593090216;2043.2337873297513;2069.286096296775;2204.162418281051;2238.2837492002564;2242.013514053819;2242.4281808138903;2242.7196600424945;2242.820574354056;2163.8485306028583;2197.055266235518;2206.558688262346;2206.7682893296214;2210.5689390568846;2045.8670186437982;2067.2971189795544;2069.2964392106683;2070.140891530013;2111.366590022987;2171.880546569938;2197;2198.274569392097;2199.912003519857;2203.0526873444414;7403.592802395866;7482.812929676747;7487.962560187164;7491.25087491252;7493.025906632158;4546.909061818778;4612.3542704021465;4627.976860115711;4657.510961349078;4666.2067448533835;2803.859807009662;2815.7465828075365;2917.970820291791;2924.1519959211805;2932.9560056599166;887.4364778365784;892.5983307511646;906.075802681268;910.1126401758299;922.0594993107061;10104.898951010542;10129.240306976932;10142.18862490999;10151.949240253825;10157.238207134495;4168.6039826216465;4223.598758117974;4293.570642935744;4300.8709738707885;4306.375575541529;8709.651613935499;8718.564071796385;8733.694320698873;8761.649534018696;8781.20969112783;4589.586937175603;4591.288350305708;4593.678442508993;4606.516315786794;4608.170529304691;3589.9102522436624;4054.4729185206324;4133.23535145999;4168.8332466700995;4170.937435938464;3562.982185089058;3635.8545658173907;3644.9817750911607;3669.3578623741273;3697.205100903319;1165.0601748089337;1183.5916608770133;1186.2348785033605;1188.1385995153444;1189.2864281431073;912.4388501071793;943.9292053096045;999.7800483893532;1012.4532752313816;1012.7569383347943;6952.130983627047;7035.226125126232;7046.964765176243;7062.929370706227;7079.433645308363;441.25207772825394;443.8291257865745;448.80476992508363;452.5429316390469;453.25213397893737;5428.050091234098;5462.153366228241;5483.396826349099;5497.39528651848;5502.724863756796;8577.571121443903;9141.177294043435;9213.677521286856;9264.027277135938;9264.397814142194;9060.093990600888;9101.77245568866;9104;9108.362414630912;9134.086591340812;6695.933040669628;6702.296258892746;6723.294054124344;6796.796096117223;6918.377346038881;6669.032990216295;6723.731050757915;6727.360900714424;6727.697253623501;6753.864922701617;7814.6483408247905;8114.06688230861;8117.472364296302;8215.917840821754;8220.342372610057;8099.352051835956;8374.916250837414;8399.328053755562;8545.359098067545;8555.57222138903;6081.726322315418;6253.812385628438;6268.655223962726;6270.0908368287255;6604.240512341143;6939;6948.270431604608;6965.129358830146;6977.162740471176;6977.651117444209;6005.669688167192;6008.909866352095;6033.064874944391;6102.359252278447;6200.503959683305;6210.4100110489435;6241.157443745036;6243.094751261133;6331.90502142459;6332.620042797447;6455.160829092188;6475.09348691193;6527.934720652923;6528.118703974903;6532.379423954717;6057.485113765203;6156.6921653918025;6181.196444462191;6205.03821907605;6206.875862482815;6221.657808820377;6234.625922444668;6266.028765541349;6283.7800676976085;6296.685165741603 05:52:10 INFO - PROCESS | 29424 | |4;prototype.html;309.972102510774;313.8681753663461;318.16164406788107;319.41387553838706;320.8443904706217;5260.789568417264;5374.973125134374;5378.8924221515545;5395.028894798935;5403.62207637053;5286.444923283048;5291.841244762653;5303.257543943851;5307.1243244864645;5318.574514038877;3954.584768599299;4046.210988857174;4149.83400663973;4162.292410290258;4192.706510544263;4130.545639979599;4174.373843923406;4175.728577642459;4180.540140584533;4188.350805625118;4110.753354798721;4119.2997190477545;4136.97931510342;4142.627163555279;4148.6266236038755;3962.286788378091;4023.6177563131455;4110.05468742188;4114.033202197481;4119.629233369011;3641.3445579795625;3647.6170002149925;3650.5801832789302;3658.652428019334;3659.505966694489;5117.232415137759;5123.871903202413;5129.717865517395;5131.897362052738;5132.820351287687;4725.621950243973;4726.243800991825;4727.432708075019;4731.290306454025;4732.242841145435;5507.476789704971;5525.033119204123;5539.695316757577;5542.224088627595;5542.91685624716;3967.226390853785;3973.940390894139;3975.662068724162;3978.085040440686;3982.920341593181;5607.495325420691;5791.82624521265;5795.623284486537;5800.8259752207505;5848.1520179574145;3910.648041676206;3970.7021973352116;3977.1449138435373;3978.960210397917;3981.223661386002;3994.9001274967777;4001.199760048002;4019.537753158366;4024.537178224483;4025.295573274665;4641.2109941310055;4642.953570464252;4645.488996210414;4650.720956742606;4654.650901182425;5564.4713752193475;5590.301212348457;5592.217089607459;5594.636348637326;5595;1406.585057408067;1427.215031732543;1428.1787971915983;1428.514305136238;1429.7926800614061;908.1735620585235;935.0929598289648;950.1543626172712;961.7066794627706;964.0793042644258;4819.373481447459;4849.393825771778;4853.466118726938;4864.318995340655;4866.245731911559;5718.342390625048;5723.284589426322;5723.627964182315;5726.685032323262;5732.34078081026;4852.053849499384;4858.17411040124;4858.611311095104;4860.416749990024;4860.927086093711;3049.969500305013;3101.1006808025872;3102;3104.0687793662264;3105.82917939511;5321.095413779667;5327.3074500314715;5341.813036543703;5359.383670877821;5365.839024829262;5776.480116789509;5860.589758716934;5925.644461332334;5927.614705044159;5940.673262970578;5439.782408703687;5451.536619387317;5455.999999999921;5464.28964234647;5470.7264636768;5831.154482599914;5833.212516310244;5840.2115714379715;5843.678597677169;5849.181114644039;5698.743556539883;5703.515201207943;5710.2862142232225;5711.029125048669;5712.314522257356;5432.483914028161;5432.945670543244;5437.864053398538;5438.510534051796;5447.1829225616475;3823.1397935464297;3944.2703099926607;3946.329124048861;3946.58560851118;3958.802059896936;5662.348829884616;5682.9147562785765;5692.686902220417;5707.400722924033;5730.713464326684;5555.111182210827;5558.499735023867;5566.916496252478;5568.220449137043;5568.220449137043;5537.335519737496;5540.667559946416;5542.445755424425;5546.833594992157;5556.055470570093;5475.2334673145;5484.862878428071;5486.423925487767;5486.643368181056;5488.91766623493;5437.53186639613;5590.077637189981;5602.747876345656;5605.523530499953;5607.579431542569;5433.673979561239;5437.728113594384;5457.890842183214;5460.5904557159165;5464.371597266365 05:52:10 INFO - PROCESS | 29424 | |5;yui.html;690.6900938145967;716.5808002318644;752.202665174915;754.1628792040838;765.414457939676;12423.565175218859;12461.37693115344;12484;12563.371831408416;12579.433925473353;11919.22525035872;11956.342401167933;11978.580749673763;13388.464461421532;13778.379972901219;653.8953767397218;812.3785304242244;821.7452589697212;822.2928281677753;823.0288259853371;663.4195079305607;665.5574043261225;666.0941120076692;666.5467482112161;797.366093955307;630.6562923206864;633.708494092718;634.9269833969083;635.209164590086;635.968201589921;629.7008920762624;630.0486265738745;634.6953462338057;636.2047440699126;637.9585326953733;465.8276437718066;467.9611262996143;498.5662473647913;603.3574243430733;611.1962768958805;11612;11619.593314234045;11628.244164129304;11653.825192622118;11671.533138674442;11373.488193031333;11445.404163962205;11448.141389395745;11475.13936454761;11671.883281167164;9516.904830951671;9614.278929080347;9772.883005452059;9968.302218844683;10070.89929100707;4014.0767623446477;4035.414864844581;4049.5343035550995;4094.7747873866924;4184.623383895464;45830;46412.53587464116;46498.07003859938;46670.29994550085;46823;9125.908740912639;9313.301502387349;9438.811223775487;9470.763230919281;9529.666461673809;15604.843951560566;15711.764323534928;15748.68502629964;15749.448769293249;15753.44862929792;6529.3470652935275;6583.374579414948;6602.7028783704845;6619.602823830585;6790.8302292442095;3749.4938183345444;3800.201957588882;3809.8095095245126;3826.3686491728554;3886.2810380079777;2877.0649538899943;2914.329704168053;2922.678505364408;2923.181509177434;2943.5290353543332;492.990140197194;511;518.0933366608435;523.2700382965742;530.212634238156;540.5054375246606;564.4017341617898;566.8667863052179;579.6406228138582;587.9823605291848;7457.627118644046;7569.394448444111;7623.809404764815;7679.500832445985;7773.650185741655;470.48011946798977;515.7679044429947;554.2157846647029;566.9992463302275;575.8963386590453;3557.519734835764;3561.7684850484634;3569.3218288525095;3602.603713591503;3701.833417496219;46858.29712554315;50901.490985090415;52353.7382313086;52615.21077183845;52796;44415;44436.55563444389;44952.55047449549;45511.317330240076;45722.77138614286;41894.58105418907;42284.788576056926;42441.15117697629;42552.14895702068;42682.1463570733;8460.788480288042;8552.914470855212;8641.654333826576;8661.566921654017;8834.602442889956;30918.690813092482;31029.0691279262;31544.52683209708;31624.841875790473;32088.35823283568;38420;38563.807180963915;39369.60630393659;41381.58618413898;41481.37777933394;10238.33450825694;10364.792704146026;10375.896241037795;10601.522931468257;10757.838632420677;11221.71945701364;11567;11609.477573509044;11639.59261425846;11793.941030294794;10340.327878687862;10374.792504150026;10527.631532896312;10692.8930710695;10826.40454774995;10810.29733067348;10941.890581094087;11249.943750281196;11401.372924489233;11450.255733377304;10619.787604247716;10779.13766898662;10997.890021099687;11141.944290278496;11343.092552595937;9009.9878391579;9224.215941645036;9283.303752218746;9560.139587437165;9569.569369378534;9053.403507021578;9586.856197157187;9798.559064841957;9827.803443931225;9828.213742900694 05:52:10 INFO - PROCESS | 29424 | __end_tp_report 05:52:10 INFO - PROCESS | 29424 | __start_cc_report 05:52:10 INFO - PROCESS | 29424 | _x_x_mozilla_cycle_collect,845 05:52:10 INFO - PROCESS | 29424 | __end_cc_report 05:52:10 INFO - PROCESS | 29424 | __startTimestamp1458651130982__endTimestamp 05:52:10 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | ------- Summary: start ------- 05:52:10 INFO - PROCESS | 29424 | Number of tests: 6 05:52:10 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | [#0] dojo.html Cycles:165 Average:4569.42 Median:4689.77 stddev:460.32 (9.8%) stddev-sans-first:434.99 05:52:10 INFO - PROCESS | 29424 | Values: 2598.6 2628.8 2691.3 2693.3 2703.2 4454.1 4487.7 4631.2 4642.7 4699.9 4605.4 4624.9 4635.9 4663.9 4693.4 4200.2 4308.6 4341.5 4402.2 4435.1 4157.1 4299.8 4370.9 4382.6 4397.7 4231.8 4258.4 4318.4 4349.7 4369.5 4285.5 4306.4 4309.7 4343.1 4347.0 4149.4 4288.6 4298.2 4310.3 4352.1 4502.6 4540.2 4568.5 4600.6 4603.3 4903.3 4931.5 4932.8 4938.8 4979.1 4762.5 4925.7 4941.6 4947.1 4984.6 4597.5 4599.1 4604.7 4610.3 4641.6 4982.5 4984.5 4987.9 5010.6 5029.0 4683.6 4774.4 4788.2 4839.4 4949.4 4838.1 4858.1 4861.2 4902.8 4927.4 4813.6 4815.7 4828.2 4833.7 4871.9 4718.6 4824.1 4890.3 4956.4 4993.9 4113.4 4117.0 4120.4 4123.2 4152.0 3637.0 3640.8 3652.8 3659.9 3677.2 4191.7 4252.8 4261.0 4299.0 4301.5 4951.6 4957.8 4961.6 4988.2 5035.0 4300.2 4309.7 4309.8 4313.5 4347.3 4288.0 4366.5 4459.6 4480.5 4505.0 4651.1 4689.8 4690.0 4693.7 4712.3 4816.2 4990.8 4991.2 4993.3 5043.7 4644.1 4681.7 4684.6 4712.0 4735.5 4919.6 4943.1 4964.4 4968.6 5021.4 4791.1 4905.2 5021.1 5043.7 5089.0 4825.0 4827.1 4849.3 4854.1 4903.7 4817.7 4818.2 4823.7 4830.9 4833.5 4573.3 4714.5 4761.2 4797.7 4835.8 4750.4 4767.9 4774.1 4811.5 4833.0 4671.2 4671.9 4673.3 4697.3 4720.7 05:52:10 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | [#1] ext.html Cycles:180 Average:43318.57 Median:195527.41 stddev:73076.97 (37.4%) stddev-sans-first:73211.33 05:52:10 INFO - PROCESS | 29424 | Values: 522.7 536.8 540.0 542.1 555.4 24864.0 25316.9 36087.8 36383.5 36403.1 38938.6 39504.4 39604.8 39607.6 39637.0 7707.9 7865.1 7901.0 7901.7 7904.4 7639.3 7746.7 7747.3 7785.8 7795.1 7701.1 7823.5 7993.2 7996.5 7997.0 7864.7 7944.8 7967.2 7968.9 7969.4 7882.8 8028.0 8038.9 8042.6 8045.5 38789.0 39254.0 39442.8 39469.6 39471.8 3092.8 3182.6 3223.3 3330.7 3371.6 28319.9 29758.6 29807.1 29872.9 30592.8 3408.9 3524.2 3526.8 3577.0 3609.1 243316.0 244123.8 244462.0 245101.0 245879.0 56523.2 56650.7 56783.0 56831.7 56841.7 64695.4 65157.3 65738.0 65770.7 65784.0 12737.1 12866.5 12887.2 12903.9 12915.7 9401.5 9434.4 9438.5 9438.9 9441.9 19730.1 20070.3 20178.7 20248.9 21119.6 7509.3 8015.8 8044.6 8051.6 8060.9 898.3 923.2 1048.1 1055.6 1056.3 27446.6 27631.2 27657.2 27887.3 28147.6 908.8 1012.3 1046.4 1047.4 1119.4 13169.7 13199.5 13325.5 13383.9 13435.9 349516.0 353424.0 354493.0 354905.0 355449.0 41868.8 42688.6 42735.0 42752.6 42854.8 1131.8 1160.4 1234.8 1261.4 1267.5 24741.4 26464.9 26800.9 26846.9 26858.9 37741.0 38464.4 38523.0 38551.8 39279.0 217373.0 218070.0 218349.0 218435.0 218727.0 31537.4 33150.2 33156.7 33179.3 33230.0 35177.8 35267.8 36108.1 36164.6 36170.1 35224.8 35875.8 36354.5 36492.0 36545.3 35065.8 35605.8 35677.8 35752.0 35868.5 34274.3 34951.0 35086.6 35102.3 35328.3 30244.2 31742.5 32217.7 32290.2 32412.7 24275.9 24444.4 24827.5 25016.1 25073.9 05:52:10 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | [#2] jquery.html Cycles:180 Average:22737.52 Median:4685.96 stddev:62290.76 (1329.3%) stddev-sans-first:62442.83 05:52:10 INFO - PROCESS | 29424 | Values: 351.7 354.4 356.9 357.3 358.0 15411.5 15964.4 15977.2 16667.2 16722.1 10192.5 10511.2 12056.6 15343.3 15360.5 4548.7 4680.2 4683.2 4688.7 4699.9 3437.6 4267.9 5981.3 5987.4 5990.6 5732.1 5963.6 5978.5 5979.6 6006.0 3376.9 4979.6 5180.1 5185.4 5945.6 4836.4 5043.6 5046.1 5050.1 5052.3 18004.4 18308.0 18851.4 19907.0 19910.7 1919.4 1926.0 1954.1 2005.6 2052.5 8891.5 8916.0 8980.6 9279.7 9326.7 1765.2 1782.6 1805.3 1832.0 1868.9 58682.0 58815.4 59645.7 60475.1 61238.0 10239.7 10240.7 10244.3 10334.3 10423.3 13149.5 13190.9 13220.8 13232.9 13241.3 6476.3 6558.1 6640.2 6745.8 6754.4 6085.7 6165.2 6268.5 6268.7 6273.1 4317.0 4340.9 4359.6 4415.9 4418.7 1669.4 1778.7 1792.0 1806.3 1808.5 875.4 889.5 902.2 909.0 949.0 15533.4 15730.6 15829.7 15970.5 16339.4 882.8 913.9 942.4 954.9 973.3 8932.2 9133.1 9180.7 9243.3 9355.9 361085.0 377668.0 377676.0 388089.0 389881.0 65501.0 67068.0 68290.7 69929.7 69999.7 897.8 902.0 914.7 915.1 944.0 14029.5 14354.9 14383.2 14397.6 14436.0 31977.0 32292.5 32550.7 32577.8 32663.2 44445.8 45582.3 45794.5 45842.8 46277.5 6771.5 6787.2 6900.8 6903.0 7027.8 8318.1 10256.0 10886.7 11223.3 11379.1 9274.7 9319.8 9660.7 9883.5 10050.3 9462.5 9567.3 9623.5 9760.6 10089.3 5388.8 8524.3 8529.7 9903.7 10114.1 7252.2 7329.9 7407.7 7492.1 7526.7 8380.6 9920.6 10230.0 10342.5 10546.8 05:52:10 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | [#3] mootools.html Cycles:180 Average:5151.51 Median:6202.77 stddev:2722.14 (43.9%) stddev-sans-first:2713.25 05:52:10 INFO - PROCESS | 29424 | Values: 1161.4 1169.9 1244.3 1304.7 1396.7 6988.9 7150.6 7162.8 7164.4 7184.4 7089.2 7270.6 7280.2 7283.7 7284.6 1890.0 1946.4 2043.2 2069.3 2204.2 2238.3 2242.0 2242.4 2242.7 2242.8 2163.8 2197.1 2206.6 2206.8 2210.6 2045.9 2067.3 2069.3 2070.1 2111.4 2171.9 2197.0 2198.3 2199.9 2203.1 7403.6 7482.8 7488.0 7491.3 7493.0 4546.9 4612.4 4628.0 4657.5 4666.2 2803.9 2815.7 2918.0 2924.2 2933.0 887.4 892.6 906.1 910.1 922.1 10104.9 10129.2 10142.2 10151.9 10157.2 4168.6 4223.6 4293.6 4300.9 4306.4 8709.7 8718.6 8733.7 8761.6 8781.2 4589.6 4591.3 4593.7 4606.5 4608.2 3589.9 4054.5 4133.2 4168.8 4170.9 3563.0 3635.9 3645.0 3669.4 3697.2 1165.1 1183.6 1186.2 1188.1 1189.3 912.4 943.9 999.8 1012.5 1012.8 6952.1 7035.2 7047.0 7062.9 7079.4 441.3 443.8 448.8 452.5 453.3 5428.1 5462.2 5483.4 5497.4 5502.7 8577.6 9141.2 9213.7 9264.0 9264.4 9060.1 9101.8 9104.0 9108.4 9134.1 6695.9 6702.3 6723.3 6796.8 6918.4 6669.0 6723.7 6727.4 6727.7 6753.9 7814.6 8114.1 8117.5 8215.9 8220.3 8099.4 8374.9 8399.3 8545.4 8555.6 6081.7 6253.8 6268.7 6270.1 6604.2 6939.0 6948.3 6965.1 6977.2 6977.7 6005.7 6008.9 6033.1 6102.4 6200.5 6210.4 6241.2 6243.1 6331.9 6332.6 6455.2 6475.1 6527.9 6528.1 6532.4 6057.5 6156.7 6181.2 6205.0 6206.9 6221.7 6234.6 6266.0 6283.8 6296.7 05:52:10 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | [#4] prototype.html Cycles:180 Average:4617.74 Median:5319.83 stddev:1351.36 (25.4%) stddev-sans-first:1315.90 05:52:10 INFO - PROCESS | 29424 | Values: 310.0 313.9 318.2 319.4 320.8 5260.8 5375.0 5378.9 5395.0 5403.6 5286.4 5291.8 5303.3 5307.1 5318.6 3954.6 4046.2 4149.8 4162.3 4192.7 4130.5 4174.4 4175.7 4180.5 4188.4 4110.8 4119.3 4137.0 4142.6 4148.6 3962.3 4023.6 4110.1 4114.0 4119.6 3641.3 3647.6 3650.6 3658.7 3659.5 5117.2 5123.9 5129.7 5131.9 5132.8 4725.6 4726.2 4727.4 4731.3 4732.2 5507.5 5525.0 5539.7 5542.2 5542.9 3967.2 3973.9 3975.7 3978.1 3982.9 5607.5 5791.8 5795.6 5800.8 5848.2 3910.6 3970.7 3977.1 3979.0 3981.2 3994.9 4001.2 4019.5 4024.5 4025.3 4641.2 4643.0 4645.5 4650.7 4654.7 5564.5 5590.3 5592.2 5594.6 5595.0 1406.6 1427.2 1428.2 1428.5 1429.8 908.2 935.1 950.2 961.7 964.1 4819.4 4849.4 4853.5 4864.3 4866.2 5718.3 5723.3 5723.6 5726.7 5732.3 4852.1 4858.2 4858.6 4860.4 4860.9 3050.0 3101.1 3102.0 3104.1 3105.8 5321.1 5327.3 5341.8 5359.4 5365.8 5776.5 5860.6 5925.6 5927.6 5940.7 5439.8 5451.5 5456.0 5464.3 5470.7 5831.2 5833.2 5840.2 5843.7 5849.2 5698.7 5703.5 5710.3 5711.0 5712.3 5432.5 5432.9 5437.9 5438.5 5447.2 3823.1 3944.3 3946.3 3946.6 3958.8 5662.3 5682.9 5692.7 5707.4 5730.7 5555.1 5558.5 5566.9 5568.2 5568.2 5537.3 5540.7 5542.4 5546.8 5556.1 5475.2 5484.9 5486.4 5486.6 5488.9 5437.5 5590.1 5602.7 5605.5 5607.6 5433.7 5437.7 5457.9 5460.6 5464.4 05:52:10 INFO - PROCESS | 29424 | 05:52:10 INFO - PROCESS | 29424 | [#5] yui.html Cycles:180 Average:12664.26 Median:45776.39 stddev:14402.52 (31.5%) stddev-sans-first:14414.85 05:52:10 INFO - PROCESS | 29424 | Values: 690.7 716.6 752.2 754.2 765.4 12423.6 12461.4 12484.0 12563.4 12579.4 11919.2 11956.3 11978.6 13388.5 13778.4 653.9 812.4 821.7 822.3 823.0 663.4 665.6 666.1 666.5 797.4 630.7 633.7 634.9 635.2 636.0 629.7 630.0 634.7 636.2 638.0 465.8 468.0 498.6 603.4 611.2 11612.0 11619.6 11628.2 11653.8 11671.5 11373.5 11445.4 11448.1 11475.1 11671.9 9516.9 9614.3 9772.9 9968.3 10070.9 4014.1 4035.4 4049.5 4094.8 4184.6 45830.0 46412.5 46498.1 46670.3 46823.0 9125.9 9313.3 9438.8 9470.8 9529.7 15604.8 15711.8 15748.7 15749.4 15753.4 6529.3 6583.4 6602.7 6619.6 6790.8 3749.5 3800.2 3809.8 3826.4 3886.3 2877.1 2914.3 2922.7 2923.2 2943.5 493.0 511.0 518.1 523.3 530.2 540.5 564.4 566.9 579.6 588.0 7457.6 7569.4 7623.8 7679.5 7773.7 470.5 515.8 554.2 567.0 575.9 3557.5 3561.8 3569.3 3602.6 3701.8 46858.3 50901.5 52353.7 52615.2 52796.0 44415.0 44436.6 44952.6 45511.3 45722.8 41894.6 42284.8 42441.2 42552.1 42682.1 8460.8 8552.9 8641.7 8661.6 8834.6 30918.7 31029.1 31544.5 31624.8 32088.4 38420.0 38563.8 39369.6 41381.6 41481.4 10238.3 10364.8 10375.9 10601.5 10757.8 11221.7 11567.0 11609.5 11639.6 11793.9 10340.3 10374.8 10527.6 10692.9 10826.4 10810.3 10941.9 11249.9 11401.4 11450.3 10619.8 10779.1 10997.9 11141.9 11343.1 9010.0 9224.2 9283.3 9560.1 9569.6 9053.4 9586.9 9798.6 9827.8 9828.2 05:52:10 INFO - PROCESS | 29424 | -------- Summary: end -------- 05:52:10 INFO - PROCESS | 29424 | 05:52:11 INFO - TEST-INFO | 29424: exit 0 05:52:11 INFO - TEST-OK | dromaeo_css | took 1115424ms 05:52:11 INFO - TEST-START | kraken 05:52:11 INFO - operating with platform_type : linux_ 05:52:11 INFO - Initialising browser for kraken test... 05:52:11 INFO - TEST-INFO | started process 29602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgMYgY/profile http://localhost:37419/getInfo.html) 05:52:15 INFO - PROCESS | 29602 | __metrics Screen width/height:1600/1200 05:52:15 INFO - PROCESS | 29602 | colorDepth:24 05:52:15 INFO - PROCESS | 29602 | Browser inner width/height: 1024/697 05:52:15 INFO - PROCESS | 29602 | __metrics 05:52:16 ERROR - PROCESS | 29602 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:52:17 INFO - TEST-INFO | 29602: exit 0 05:52:17 INFO - Browser initialized. 05:52:17 INFO - Running cycle 1/1 for kraken test... 05:52:17 INFO - TEST-INFO | started process 29684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgMYgY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:29 INFO - PROCESS | 29684 | RSS: Main: 157917184 05:52:29 INFO - PROCESS | 29684 | 05:52:32 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37419/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:32 INFO - PROCESS | 29684 | RSS: Main: 198430720 05:52:32 INFO - PROCESS | 29684 | 05:52:35 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37419/tests/kraken/driver.html?testName=audio-dft) 05:52:36 INFO - PROCESS | 29684 | RSS: Main: 189026304 05:52:36 INFO - PROCESS | 29684 | 05:52:39 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37419/tests/kraken/driver.html?testName=audio-fft) 05:52:39 INFO - PROCESS | 29684 | RSS: Main: 174383104 05:52:39 INFO - PROCESS | 29684 | 05:52:41 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37419/tests/kraken/driver.html?testName=audio-oscillator) 05:52:42 INFO - PROCESS | 29684 | RSS: Main: 176078848 05:52:42 INFO - PROCESS | 29684 | 05:52:44 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37419/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:45 INFO - PROCESS | 29684 | RSS: Main: 176185344 05:52:45 INFO - PROCESS | 29684 | 05:52:48 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37419/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:48 INFO - PROCESS | 29684 | RSS: Main: 178323456 05:52:48 INFO - PROCESS | 29684 | 05:52:52 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37419/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:52 INFO - PROCESS | 29684 | RSS: Main: 179576832 05:52:52 INFO - PROCESS | 29684 | 05:52:55 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37419/tests/kraken/driver.html?testName=json-parse-financial) 05:52:56 INFO - PROCESS | 29684 | RSS: Main: 177446912 05:52:56 INFO - PROCESS | 29684 | 05:52:58 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37419/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:58 INFO - PROCESS | 29684 | RSS: Main: 188887040 05:52:58 INFO - PROCESS | 29684 | 05:53:00 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:01 INFO - PROCESS | 29684 | RSS: Main: 183013376 05:53:01 INFO - PROCESS | 29684 | 05:53:03 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:03 INFO - PROCESS | 29684 | RSS: Main: 192610304 05:53:03 INFO - PROCESS | 29684 | 05:53:06 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:06 INFO - PROCESS | 29684 | RSS: Main: 201588736 05:53:06 INFO - PROCESS | 29684 | 05:53:09 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:09 INFO - PROCESS | 29684 | RSS: Main: 201158656 05:53:09 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37419/tests/kraken/driver.html?testName=ai-astar) 05:53:11 INFO - PROCESS | 29684 | RSS: Main: 261246976 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | __start_tp_report 05:53:11 INFO - PROCESS | 29684 | _x_x_mozilla_page_load 05:53:11 INFO - PROCESS | 29684 | _x_x_mozilla_page_load_details 05:53:11 INFO - PROCESS | 29684 | |i|pagename|runs| 05:53:11 INFO - PROCESS | 29684 | |0;ai-astar;110;113;107;112;113;112;100;112;114;113 05:53:11 INFO - PROCESS | 29684 | |1;audio-beat-detection;149;129;150;166;130;152;152;131;163;133 05:53:11 INFO - PROCESS | 29684 | |2;audio-dft;161;161;160;160;161;160;163;161;160;161 05:53:11 INFO - PROCESS | 29684 | |3;audio-fft;73;73;97;94;72;73;72;108;89;74 05:53:11 INFO - PROCESS | 29684 | |4;audio-oscillator;93;93;145;93;93;93;135;92;93;142 05:53:11 INFO - PROCESS | 29684 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 05:53:11 INFO - PROCESS | 29684 | |6;imaging-darkroom;146;147;146;146;147;146;146;147;146;146 05:53:11 INFO - PROCESS | 29684 | |7;imaging-desaturate;96;96;95;95;95;96;95;95;96;95 05:53:11 INFO - PROCESS | 29684 | |8;json-parse-financial;67;71;69;68;68;67;69;79;67;67 05:53:11 INFO - PROCESS | 29684 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;63;64;64 05:53:11 INFO - PROCESS | 29684 | |10;stanford-crypto-aes;88;81;82;88;82;82;82;81;83;81 05:53:11 INFO - PROCESS | 29684 | |11;stanford-crypto-ccm;117;115;125;115;115;114;125;124;121;126 05:53:11 INFO - PROCESS | 29684 | |12;stanford-crypto-pbkdf2;137;140;135;140;143;136;138;138;135;126 05:53:11 INFO - PROCESS | 29684 | |13;stanford-crypto-sha256-iterative;65;65;66;66;66;65;64;67;65;64 05:53:11 INFO - PROCESS | 29684 | __end_tp_report 05:53:11 INFO - PROCESS | 29684 | __start_cc_report 05:53:11 INFO - PROCESS | 29684 | _x_x_mozilla_cycle_collect,1171 05:53:11 INFO - PROCESS | 29684 | __end_cc_report 05:53:11 INFO - PROCESS | 29684 | __startTimestamp1458651191954__endTimestamp 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | ------- Summary: start ------- 05:53:11 INFO - PROCESS | 29684 | Number of tests: 14 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:4.22 (3.8%) stddev-sans-first:4.47 05:53:11 INFO - PROCESS | 29684 | Values: 110.0 113.0 107.0 112.0 113.0 112.0 100.0 112.0 114.0 113.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:151.00 stddev:13.83 (9.2%) stddev-sans-first:14.62 05:53:11 INFO - PROCESS | 29684 | Values: 149.0 129.0 150.0 166.0 130.0 152.0 152.0 131.0 163.0 133.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 05:53:11 INFO - PROCESS | 29684 | Values: 161.0 161.0 160.0 160.0 161.0 160.0 163.0 161.0 160.0 161.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#3] audio-fft Cycles:10 Average:82.50 Median:73.50 stddev:13.33 (18.1%) stddev-sans-first:13.68 05:53:11 INFO - PROCESS | 29684 | Values: 73.0 73.0 97.0 94.0 72.0 73.0 72.0 108.0 89.0 74.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.00 stddev:23.22 (25.0%) stddev-sans-first:24.06 05:53:11 INFO - PROCESS | 29684 | Values: 93.0 93.0 145.0 93.0 93.0 93.0 135.0 92.0 93.0 142.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:53:11 INFO - PROCESS | 29684 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:53:11 INFO - PROCESS | 29684 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:53:11 INFO - PROCESS | 29684 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:68.50 stddev:3.68 (5.4%) stddev-sans-first:3.81 05:53:11 INFO - PROCESS | 29684 | Values: 67.0 71.0 69.0 68.0 68.0 67.0 69.0 79.0 67.0 67.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 05:53:11 INFO - PROCESS | 29684 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.00 stddev:2.71 (3.3%) stddev-sans-first:2.19 05:53:11 INFO - PROCESS | 29684 | Values: 88.0 81.0 82.0 88.0 82.0 82.0 82.0 81.0 83.0 81.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:122.50 stddev:4.97 (4.1%) stddev-sans-first:5.17 05:53:11 INFO - PROCESS | 29684 | Values: 117.0 115.0 125.0 115.0 115.0 114.0 125.0 124.0 121.0 126.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.80 Median:138.00 stddev:4.54 (3.3%) stddev-sans-first:4.82 05:53:11 INFO - PROCESS | 29684 | Values: 137.0 140.0 135.0 140.0 143.0 136.0 138.0 138.0 135.0 126.0 05:53:11 INFO - PROCESS | 29684 | 05:53:11 INFO - PROCESS | 29684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 05:53:11 INFO - PROCESS | 29684 | Values: 65.0 65.0 66.0 66.0 66.0 65.0 64.0 67.0 65.0 64.0 05:53:11 INFO - PROCESS | 29684 | -------- Summary: end -------- 05:53:11 INFO - PROCESS | 29684 | 05:53:12 INFO - TEST-INFO | 29684: exit 0 05:53:12 INFO - TEST-OK | kraken | took 61123ms 05:53:12 INFO - SUITE-END | took 1176s 05:53:13 INFO - Completed test suite (00:19:36) 05:53:13 INFO - javascript benchmark 05:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2598.597217431298, 2628.8291261068016, 2691.34062154772, 2693.299742067063, 2703.229579569823, 4454.109178164372, 4487.730736155833, 4631.16639004979, 4642.6982246153975, 4699.859004229875, 4605.355250264965, 4624.907501849961, 4635.907281854369, 4663.930041049379, 4693.366395536602, 4200.222958752625, 4308.612224899758, 4341.522432532419, 4402.185595664812, 4435.090806384699, 4157.147784704143, 4299.828006879721, 4370.868873933771, 4382.583654552813, 4397.714148580348, 4231.788410579474, 4258.361245813122, 4318.395424640553, 4349.69552131351, 4369.519352871182, 4285.5071666758095, 4306.44016277885, 4309.676774241944, 4343.066240758252, 4346.956530434687, 4149.3775933609895, 4288.635465985364, 4298.226319262531, 4310.267254566731, 4352.064306174156, 4502.57225563571, 4540.228161212602, 4568.474625418086, 4600.5629465200755, 4603.309503574457, 4903.289023091632, 4931.482194369575, 4932.80268789248, 4938.777755001033, 4979.053979743837, 4762.452317983407, 4925.729084900329, 4941.579965702919, 4947.134251506008, 4984.6261530385, 4597.471290801601, 4599.08018396322, 4604.723716577016, 4610.331501932201, 4641.559051890065, 4982.526659967298, 4984.526469985346, 4987.850364489072, 5010.649254552146, 5029.0, 4683.625309975194, 4774.355462012653, 4788.186008378584, 4839.443464001685, 4949.381327334083, 4838.129136755418, 4858.05267972749, 4861.222204447342, 4902.828401005948, 4927.43334516528, 4813.638977076734, 4815.686980346266, 4828.203346447867, 4833.685810422311, 4871.853844384674, 4718.646101542398, 4824.131656301899, 4890.2909078184175, 4956.430010548833, 4993.875153121201, 4113.444684967491, 4116.9794151029655, 4120.443740095049, 4123.154753275571, 4151.99999999994, 3637.0361854108683, 3640.8179591020344, 3652.817359132086, 3659.9451008234896, 3677.2093999790172, 4191.664666826647, 4252.808623611945, 4260.978695106504, 4299.0, 4301.483821941387, 4951.579115775199, 4957.7769000395065, 4961.578265847371, 4988.176950803149, 5035.043341765053, 4300.161468513672, 4309.676774241944, 4309.806058727365, 4313.503947046067, 4347.3044312910415, 4287.978560107242, 4366.541513141138, 4459.643228541709, 4480.507144214133, 4505.0, 4651.1162879053545, 4689.765511724332, 4690.0150968295675, 4693.6949098308505, 4712.269598212282, 4816.229403295456, 4990.750462476934, 4991.226359914219, 4993.27597498368, 5043.722595257296, 4644.071185762793, 4681.672282940298, 4684.5549672781035, 4711.9764401179145, 4735.526447355374, 4919.606431485401, 4943.060818444484, 4964.404271487445, 4968.552830245295, 5021.372328458942, 4791.137595232753, 4905.2151655734915, 5021.096202683552, 5043.747812609281, 5089.033083714231, 4825.0, 4827.058723549015, 4849.2968519565175, 4854.126257273583, 4903.656744027884, 4817.710937343771, 4818.156822555969, 4823.710577365369, 4830.879228019187, 4833.492483289204, 4573.268277075652, 4714.457837348748, 4761.16679581065, 4797.664163508661, 4835.8065677372515, 4750.429948406213, 4767.880802979815, 4774.116788394158, 4811.49479304682, 4832.975835120802, 4671.205894997791, 4671.929921051119, 4673.252279635242, 4697.271922851964, 4720.716756994591], "unit": "score", "name": "dojo.html", "value": 4541.579226292127}, {"lowerIsBetter": false, "replicates": [522.7203446156304, 536.8228484600082, 540.0441219042298, 542.121762744354, 555.3752028967411, 24864.005439782388, 25316.87341563292, 36087.81956090219, 36383.454248186295, 36403.089922751875, 38938.610613893856, 39504.40743388851, 39604.80197599015, 39607.60392396075, 39636.99999999993, 7707.884381734279, 7865.056193256817, 7900.960495197544, 7901.683932642687, 7904.407169462284, 7639.274268944441, 7746.651400686983, 7747.2640099190485, 7785.805354866117, 7795.1035630902325, 7701.075870895473, 7823.5305881647, 7993.200679932019, 7996.520208787462, 7997.0, 7864.68541258349, 7944.801379965489, 7967.203279672044, 7968.920310796876, 7969.442139050268, 7882.80292992674, 8028.036635603765, 8038.919610803934, 8042.597870106471, 8045.517268963881, 38789.0, 39254.0, 39442.802785986176, 39469.60530394688, 39471.802640986614, 3092.78350515464, 3182.6499085100622, 3223.3231021485517, 3330.6835850594157, 3371.6322308899985, 28319.904506117495, 29758.553621695693, 29807.10578682643, 29872.850635746898, 30592.847035764902, 3408.9147771305916, 3524.207053412987, 3526.84129214186, 3576.982115089434, 3609.1157666371905, 243316.0, 244123.77938110373, 244462.0, 245101.0, 245879.0, 56523.15215271774, 56650.716746416, 56783.0, 56831.715841421355, 56841.71579142078, 64695.35304646893, 65157.34842651607, 65738.0, 65770.67114664492, 65784.0, 12737.108402411928, 12866.549670761478, 12887.226766394046, 12903.870961290268, 12915.741685166431, 9401.529923503798, 9434.433933963985, 9438.48088355147, 9438.858417123749, 9441.875577994897, 19730.112144953513, 20070.297539586045, 20178.697319540217, 20248.873868243918, 21119.577608448053, 7509.286617771303, 8015.839683206304, 8044.597770111471, 8051.63767630458, 8060.919390806017, 898.2993265253114, 923.1922068190333, 1048.0829274384914, 1055.5830446973403, 1056.265895202842, 27446.5883011755, 27631.171064868086, 27657.170284891487, 27887.302817429725, 28147.577786333222, 908.7637214324191, 1012.2863381316155, 1046.3617193511952, 1047.3872784421046, 1119.3955264157428, 13169.736605268032, 13199.53801616958, 13325.466981320833, 13383.933080334731, 13435.865641343657, 349516.0, 353424.0, 354493.0, 354905.0, 355449.0, 41868.79065604713, 42688.57311426846, 42735.0, 42752.57247427548, 42854.78572607117, 1131.8189089745765, 1160.3791971295316, 1234.8394708687813, 1261.375619068567, 1267.4866678994838, 24741.381465463506, 26464.8676756615, 26800.865995669898, 26846.865765671046, 26858.865705671345, 37741.0, 38464.423033655075, 38523.0, 38551.807240963615, 39279.0, 217373.0, 218070.0, 218349.0, 218435.0, 218727.0, 31537.36925261436, 33150.171245718084, 33156.66843331536, 33179.336413271114, 33230.0, 35177.82411087928, 35267.82366088256, 36108.09729756777, 36164.63835361613, 36170.09574760547, 35224.82387588046, 35875.82062089777, 36354.4546831803, 36492.0, 36545.26909461849, 35065.824670876485, 35605.82197088998, 35677.82161089178, 35752.0, 35868.461973069905, 34274.31451370909, 34951.0, 35086.64913350834, 35102.29795404027, 35328.29343413169, 30244.24389390283, 31742.52386214255, 32217.677823221467, 32290.192745181557, 32412.675873240965, 24275.878620606785, 24444.388890277172, 24827.50344993054, 25016.124435644666, 25073.87463062673], "unit": "score", "name": "ext.html", "value": 17214.35953886005}, {"lowerIsBetter": false, "replicates": [351.7098393825095, 354.43467669067826, 356.88758041217017, 357.29256072975505, 357.97975769058206, 15411.537653870373, 15964.361425542978, 15977.201139943, 16667.24997375118, 16722.08028558429, 10192.541335639895, 10511.211659125558, 12056.638300850967, 15343.3095510702, 15360.462383816568, 4548.7270763754195, 4680.204365257898, 4683.2038553446, 4688.718676879381, 4699.929501057487, 3437.6218615952225, 4267.914641707164, 5981.312149102843, 5987.401259874021, 5990.580659353847, 5732.054211055191, 5963.55273354498, 5978.461938425541, 5979.5515336349945, 6005.969970150143, 3376.9493457598155, 4979.626528010395, 5180.093483640348, 5185.429602743714, 5945.613535120225, 4836.41962964443, 5043.571296439807, 5046.1169295373165, 5050.065737838511, 5052.292679024939, 18004.369847055423, 18308.0, 18851.43445696631, 19907.0, 19910.701339479918, 1919.4145785535407, 1925.951851203717, 1954.0913475233942, 2005.5788284460282, 2052.5279185787354, 8891.510966896818, 8915.955420222923, 8980.55097245135, 9279.67521136757, 9326.673566425143, 1765.1968354398846, 1782.5721826761614, 1805.2959345855127, 1831.9633607327912, 1868.8972106534136, 58682.0, 58815.41184588142, 59645.7017714913, 60475.09287360693, 61238.0, 10239.692809215736, 10240.743981400525, 10244.282900196915, 10334.328268662513, 10423.322484038514, 13149.53976610814, 13190.868091318964, 13220.801687974688, 13232.933835330954, 13241.337933103307, 6476.255230648441, 6558.147440832661, 6640.203175618956, 6745.763898263537, 6754.425873800684, 6085.726142323606, 6165.229346331708, 6268.529860260499, 6268.749250029948, 6273.059041143773, 4316.956830431718, 4340.934885976713, 4359.607635312774, 4415.933760993587, 4418.734875907456, 1669.4323929863904, 1778.6709458750172, 1791.973120403195, 1806.2504060814877, 1808.493621785902, 875.3741075131312, 889.4752096263236, 902.1880307723102, 909.0, 948.9656274660515, 15533.378664853279, 15730.606734831492, 15829.68340633181, 15970.520884373487, 16339.428120015742, 882.8146089321186, 913.9268858491305, 942.3874481587023, 954.9474778887228, 973.2846357926918, 8932.240759535382, 9133.086691330947, 9180.678676246433, 9243.306751993627, 9355.90644093564, 361085.0, 377668.0, 377676.0, 388089.0, 389881.0, 65501.0, 67068.0, 68290.65854670794, 69929.65035174893, 69999.65000174966, 897.7665806890255, 901.9774505637412, 914.7072936660338, 915.1306259053925, 944.0370821761902, 14029.508967186099, 14354.856451435351, 14383.20892350889, 14397.568072957829, 14436.0, 31977.0, 32292.515612266303, 32550.674493255712, 32577.837110815242, 32663.173510621673, 44445.77777111094, 45582.31626525671, 45794.542054579026, 45842.77078614719, 46277.537224627325, 6771.548550162183, 6787.185537735306, 6900.758473453405, 6902.965485172542, 7027.789166325018, 8318.085010648945, 10256.0, 10886.727831803952, 11223.326600403676, 11379.146564007568, 9274.721758347261, 9319.767005824908, 9660.71017869465, 9883.50582470888, 10050.296479246383, 9462.526873656152, 9567.282453816131, 9623.470709111067, 9760.56077476501, 10089.29374943747, 5388.811391601275, 8524.27543658796, 8529.701460448854, 9903.702888913343, 10114.140298074746, 7252.202257751748, 7329.9267007329245, 7407.703691852265, 7492.063492063492, 7526.698932042657, 8380.58097095155, 9920.553575088994, 10230.0, 10342.482875856327, 10546.78906421852], "unit": "score", "name": "jquery.html", "value": 7753.060261604204}, {"lowerIsBetter": false, "replicates": [1161.3612513117782, 1169.894709476147, 1244.2721008210199, 1304.726007538417, 1396.6648004478927, 6988.895166572499, 7150.606716630589, 7162.820929476772, 7164.391026762718, 7184.425245980322, 7089.18474375447, 7270.636468176584, 7280.235575264601, 7283.708651653941, 7284.599347035924, 1889.962200755984, 1946.3771593090216, 2043.2337873297513, 2069.286096296775, 2204.162418281051, 2238.2837492002564, 2242.013514053819, 2242.4281808138903, 2242.7196600424945, 2242.820574354056, 2163.8485306028583, 2197.055266235518, 2206.558688262346, 2206.7682893296214, 2210.5689390568846, 2045.8670186437982, 2067.2971189795544, 2069.2964392106683, 2070.140891530013, 2111.366590022987, 2171.880546569938, 2197.0, 2198.274569392097, 2199.912003519857, 2203.0526873444414, 7403.592802395866, 7482.812929676747, 7487.962560187164, 7491.25087491252, 7493.025906632158, 4546.909061818778, 4612.3542704021465, 4627.976860115711, 4657.510961349078, 4666.2067448533835, 2803.859807009662, 2815.7465828075365, 2917.970820291791, 2924.1519959211805, 2932.9560056599166, 887.4364778365784, 892.5983307511646, 906.075802681268, 910.1126401758299, 922.0594993107061, 10104.898951010542, 10129.240306976932, 10142.18862490999, 10151.949240253825, 10157.238207134495, 4168.6039826216465, 4223.598758117974, 4293.570642935744, 4300.8709738707885, 4306.375575541529, 8709.651613935499, 8718.564071796385, 8733.694320698873, 8761.649534018696, 8781.20969112783, 4589.586937175603, 4591.288350305708, 4593.678442508993, 4606.516315786794, 4608.170529304691, 3589.9102522436624, 4054.4729185206324, 4133.23535145999, 4168.8332466700995, 4170.937435938464, 3562.982185089058, 3635.8545658173907, 3644.9817750911607, 3669.3578623741273, 3697.205100903319, 1165.0601748089337, 1183.5916608770133, 1186.2348785033605, 1188.1385995153444, 1189.2864281431073, 912.4388501071793, 943.9292053096045, 999.7800483893532, 1012.4532752313816, 1012.7569383347943, 6952.130983627047, 7035.226125126232, 7046.964765176243, 7062.929370706227, 7079.433645308363, 441.25207772825394, 443.8291257865745, 448.80476992508363, 452.5429316390469, 453.25213397893737, 5428.050091234098, 5462.153366228241, 5483.396826349099, 5497.39528651848, 5502.724863756796, 8577.571121443903, 9141.177294043435, 9213.677521286856, 9264.027277135938, 9264.397814142194, 9060.093990600888, 9101.77245568866, 9104.0, 9108.362414630912, 9134.086591340812, 6695.933040669628, 6702.296258892746, 6723.294054124344, 6796.796096117223, 6918.377346038881, 6669.032990216295, 6723.731050757915, 6727.360900714424, 6727.697253623501, 6753.864922701617, 7814.6483408247905, 8114.06688230861, 8117.472364296302, 8215.917840821754, 8220.342372610057, 8099.352051835956, 8374.916250837414, 8399.328053755562, 8545.359098067545, 8555.57222138903, 6081.726322315418, 6253.812385628438, 6268.655223962726, 6270.0908368287255, 6604.240512341143, 6939.0, 6948.270431604608, 6965.129358830146, 6977.162740471176, 6977.651117444209, 6005.669688167192, 6008.909866352095, 6033.064874944391, 6102.359252278447, 6200.503959683305, 6210.4100110489435, 6241.157443745036, 6243.094751261133, 6331.90502142459, 6332.620042797447, 6455.160829092188, 6475.09348691193, 6527.934720652923, 6528.118703974903, 6532.379423954717, 6057.485113765203, 6156.6921653918025, 6181.196444462191, 6205.03821907605, 6206.875862482815, 6221.657808820377, 6234.625922444668, 6266.028765541349, 6283.7800676976085, 6296.685165741603], "unit": "score", "name": "mootools.html", "value": 4125.967208334443}, {"lowerIsBetter": false, "replicates": [309.972102510774, 313.8681753663461, 318.16164406788107, 319.41387553838706, 320.8443904706217, 5260.789568417264, 5374.973125134374, 5378.8924221515545, 5395.028894798935, 5403.62207637053, 5286.444923283048, 5291.841244762653, 5303.257543943851, 5307.1243244864645, 5318.574514038877, 3954.584768599299, 4046.210988857174, 4149.83400663973, 4162.292410290258, 4192.706510544263, 4130.545639979599, 4174.373843923406, 4175.728577642459, 4180.540140584533, 4188.350805625118, 4110.753354798721, 4119.2997190477545, 4136.97931510342, 4142.627163555279, 4148.6266236038755, 3962.286788378091, 4023.6177563131455, 4110.05468742188, 4114.033202197481, 4119.629233369011, 3641.3445579795625, 3647.6170002149925, 3650.5801832789302, 3658.652428019334, 3659.505966694489, 5117.232415137759, 5123.871903202413, 5129.717865517395, 5131.897362052738, 5132.820351287687, 4725.621950243973, 4726.243800991825, 4727.432708075019, 4731.290306454025, 4732.242841145435, 5507.476789704971, 5525.033119204123, 5539.695316757577, 5542.224088627595, 5542.91685624716, 3967.226390853785, 3973.940390894139, 3975.662068724162, 3978.085040440686, 3982.920341593181, 5607.495325420691, 5791.82624521265, 5795.623284486537, 5800.8259752207505, 5848.1520179574145, 3910.648041676206, 3970.7021973352116, 3977.1449138435373, 3978.960210397917, 3981.223661386002, 3994.9001274967777, 4001.199760048002, 4019.537753158366, 4024.537178224483, 4025.295573274665, 4641.2109941310055, 4642.953570464252, 4645.488996210414, 4650.720956742606, 4654.650901182425, 5564.4713752193475, 5590.301212348457, 5592.217089607459, 5594.636348637326, 5595.0, 1406.585057408067, 1427.215031732543, 1428.1787971915983, 1428.514305136238, 1429.7926800614061, 908.1735620585235, 935.0929598289648, 950.1543626172712, 961.7066794627706, 964.0793042644258, 4819.373481447459, 4849.393825771778, 4853.466118726938, 4864.318995340655, 4866.245731911559, 5718.342390625048, 5723.284589426322, 5723.627964182315, 5726.685032323262, 5732.34078081026, 4852.053849499384, 4858.17411040124, 4858.611311095104, 4860.416749990024, 4860.927086093711, 3049.969500305013, 3101.1006808025872, 3102.0, 3104.0687793662264, 3105.82917939511, 5321.095413779667, 5327.3074500314715, 5341.813036543703, 5359.383670877821, 5365.839024829262, 5776.480116789509, 5860.589758716934, 5925.644461332334, 5927.614705044159, 5940.673262970578, 5439.782408703687, 5451.536619387317, 5455.999999999921, 5464.28964234647, 5470.7264636768, 5831.154482599914, 5833.212516310244, 5840.2115714379715, 5843.678597677169, 5849.181114644039, 5698.743556539883, 5703.515201207943, 5710.2862142232225, 5711.029125048669, 5712.314522257356, 5432.483914028161, 5432.945670543244, 5437.864053398538, 5438.510534051796, 5447.1829225616475, 3823.1397935464297, 3944.2703099926607, 3946.329124048861, 3946.58560851118, 3958.802059896936, 5662.348829884616, 5682.9147562785765, 5692.686902220417, 5707.400722924033, 5730.713464326684, 5555.111182210827, 5558.499735023867, 5566.916496252478, 5568.220449137043, 5568.220449137043, 5537.335519737496, 5540.667559946416, 5542.445755424425, 5546.833594992157, 5556.055470570093, 5475.2334673145, 5484.862878428071, 5486.423925487767, 5486.643368181056, 5488.91766623493, 5437.53186639613, 5590.077637189981, 5602.747876345656, 5605.523530499953, 5607.579431542569, 5433.673979561239, 5437.728113594384, 5457.890842183214, 5460.5904557159165, 5464.371597266365], "unit": "score", "name": "prototype.html", "value": 4185.107562608904}, {"lowerIsBetter": false, "replicates": [690.6900938145967, 716.5808002318644, 752.202665174915, 754.1628792040838, 765.414457939676, 12423.565175218859, 12461.37693115344, 12484.0, 12563.371831408416, 12579.433925473353, 11919.22525035872, 11956.342401167933, 11978.580749673763, 13388.464461421532, 13778.379972901219, 653.8953767397218, 812.3785304242244, 821.7452589697212, 822.2928281677753, 823.0288259853371, 663.4195079305607, 665.5574043261225, 666.0941120076692, 666.5467482112161, 797.366093955307, 630.6562923206864, 633.708494092718, 634.9269833969083, 635.209164590086, 635.968201589921, 629.7008920762624, 630.0486265738745, 634.6953462338057, 636.2047440699126, 637.9585326953733, 465.8276437718066, 467.9611262996143, 498.5662473647913, 603.3574243430733, 611.1962768958805, 11612.0, 11619.593314234045, 11628.244164129304, 11653.825192622118, 11671.533138674442, 11373.488193031333, 11445.404163962205, 11448.141389395745, 11475.13936454761, 11671.883281167164, 9516.904830951671, 9614.278929080347, 9772.883005452059, 9968.302218844683, 10070.89929100707, 4014.0767623446477, 4035.414864844581, 4049.5343035550995, 4094.7747873866924, 4184.623383895464, 45830.0, 46412.53587464116, 46498.07003859938, 46670.29994550085, 46823.0, 9125.908740912639, 9313.301502387349, 9438.811223775487, 9470.763230919281, 9529.666461673809, 15604.843951560566, 15711.764323534928, 15748.68502629964, 15749.448769293249, 15753.44862929792, 6529.3470652935275, 6583.374579414948, 6602.7028783704845, 6619.602823830585, 6790.8302292442095, 3749.4938183345444, 3800.201957588882, 3809.8095095245126, 3826.3686491728554, 3886.2810380079777, 2877.0649538899943, 2914.329704168053, 2922.678505364408, 2923.181509177434, 2943.5290353543332, 492.990140197194, 511.0, 518.0933366608435, 523.2700382965742, 530.212634238156, 540.5054375246606, 564.4017341617898, 566.8667863052179, 579.6406228138582, 587.9823605291848, 7457.627118644046, 7569.394448444111, 7623.809404764815, 7679.500832445985, 7773.650185741655, 470.48011946798977, 515.7679044429947, 554.2157846647029, 566.9992463302275, 575.8963386590453, 3557.519734835764, 3561.7684850484634, 3569.3218288525095, 3602.603713591503, 3701.833417496219, 46858.29712554315, 50901.490985090415, 52353.7382313086, 52615.21077183845, 52796.0, 44415.0, 44436.55563444389, 44952.55047449549, 45511.317330240076, 45722.77138614286, 41894.58105418907, 42284.788576056926, 42441.15117697629, 42552.14895702068, 42682.1463570733, 8460.788480288042, 8552.914470855212, 8641.654333826576, 8661.566921654017, 8834.602442889956, 30918.690813092482, 31029.0691279262, 31544.52683209708, 31624.841875790473, 32088.35823283568, 38420.0, 38563.807180963915, 39369.60630393659, 41381.58618413898, 41481.37777933394, 10238.33450825694, 10364.792704146026, 10375.896241037795, 10601.522931468257, 10757.838632420677, 11221.71945701364, 11567.0, 11609.477573509044, 11639.59261425846, 11793.941030294794, 10340.327878687862, 10374.792504150026, 10527.631532896312, 10692.8930710695, 10826.40454774995, 10810.29733067348, 10941.890581094087, 11249.943750281196, 11401.372924489233, 11450.255733377304, 10619.787604247716, 10779.13766898662, 10997.890021099687, 11141.944290278496, 11343.092552595937, 9009.9878391579, 9224.215941645036, 9283.303752218746, 9560.139587437165, 9569.569369378534, 9053.403507021578, 9586.856197157187, 9798.559064841957, 9827.803443931225, 9828.213742900694], "unit": "score", "name": "yui.html", "value": 5756.942911060543}], "name": "dromaeo_css", "value": 6261.428147077798}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 112.0, 113.0, 112.0, 100.0, 112.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [149.0, 129.0, 150.0, 166.0, 130.0, 152.0, 152.0, 131.0, 163.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 163.0, 161.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 97.0, 94.0, 72.0, 73.0, 72.0, 108.0, 89.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 145.0, 93.0, 93.0, 93.0, 135.0, 92.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 69.0, 68.0, 68.0, 67.0, 69.0, 79.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 82.0, 88.0, 82.0, 82.0, 82.0, 81.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 125.0, 115.0, 115.0, 114.0, 125.0, 124.0, 121.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [137.0, 140.0, 135.0, 140.0, 143.0, 136.0, 138.0, 138.0, 135.0, 126.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 64.0, 67.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1503.0}]} 05:53:13 INFO - Return code: 0 05:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:53:13 ERROR - # TBPL SUCCESS # 05:53:13 INFO - Running post-action listener: _resource_record_post_action 05:53:13 INFO - Running post-run listener: _resource_record_post_run 05:53:14 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 421412864; Read time: 28; Write time: 353996 05:53:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109682688; Read time: 0; Write time: 112960 05:53:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287518720; Read time: 28; Write time: 202348 05:53:14 INFO - Running post-run listener: _upload_blobber_files 05:53:14 INFO - Blob upload gear active. 05:53:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:14 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 05:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:53:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:15 INFO - (blobuploader) - INFO - Done attempting. 05:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:17 INFO - (blobuploader) - INFO - Done attempting. 05:53:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:17 INFO - Return code: 0 05:53:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d6c2eea5f45ac2667870c4e90b66aab0d5ba8860b2a30fbce466d3ec2d4ff22f5333562255069a5c8c1b55930029a106ba9c4e938aeec46343907f2d378a3e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0139687d62c89cad92fadf7c606365cc457517d7606ec35d44d30ba1e699b6f12424b5f02c190f0dd652da72ce41306ab3ed6357e1a34747640dbe5dcddd0ea"} 05:53:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:17 INFO - Contents: 05:53:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d6c2eea5f45ac2667870c4e90b66aab0d5ba8860b2a30fbce466d3ec2d4ff22f5333562255069a5c8c1b55930029a106ba9c4e938aeec46343907f2d378a3e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0139687d62c89cad92fadf7c606365cc457517d7606ec35d44d30ba1e699b6f12424b5f02c190f0dd652da72ce41306ab3ed6357e1a34747640dbe5dcddd0ea"} 05:53:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:17 INFO - Copying logs to upload dir... 05:53:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.301632 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-03-22 05:53:17.265731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 05:53:17.269072) ========= 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=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d6c2eea5f45ac2667870c4e90b66aab0d5ba8860b2a30fbce466d3ec2d4ff22f5333562255069a5c8c1b55930029a106ba9c4e938aeec46343907f2d378a3e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0139687d62c89cad92fadf7c606365cc457517d7606ec35d44d30ba1e699b6f12424b5f02c190f0dd652da72ce41306ab3ed6357e1a34747640dbe5dcddd0ea"} build_url:https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/RNDGzwTOQoaUuBX9kjtnLQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d6c2eea5f45ac2667870c4e90b66aab0d5ba8860b2a30fbce466d3ec2d4ff22f5333562255069a5c8c1b55930029a106ba9c4e938aeec46343907f2d378a3e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0139687d62c89cad92fadf7c606365cc457517d7606ec35d44d30ba1e699b6f12424b5f02c190f0dd652da72ce41306ab3ed6357e1a34747640dbe5dcddd0ea"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 05:53:17.352078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:53:17.352853) ========= 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=62c568580acbfdaac3eec7be000001dc-1458648759.819057-1617045818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:53:17.453254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 05:53:17.453988) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 05:53:17.454684) ========= ========= Total master_lag: 0.49 =========