builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1457616537.97 results: success (0) buildid: 20160310025316 builduid: 71cdc01cf07e4e06b30287eb71c66d2e revision: dd1abe874252e507b825a0a4e1063b0e13578288 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:57.969532) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:57.969950) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:57.970247) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006384 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.019055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.019347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.045806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.046081) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.110393) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.110692) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.111049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.111348) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-10 05:28:58-- 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-10 05:28:58 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.278780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.279101) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015746 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.329258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 05:28:58.329643) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd1abe874252e507b825a0a4e1063b0e13578288 --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 dd1abe874252e507b825a0a4e1063b0e13578288 --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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-10 05:28:58,378 truncating revision to first 12 chars 2016-03-10 05:28:58,379 Setting DEBUG logging. 2016-03-10 05:28:58,379 attempt 1/10 2016-03-10 05:28:58,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd1abe874252?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 05:28:59,103 unpacking tar archive at: mozilla-central-dd1abe874252/testing/mozharness/ program finished with exit code 0 elapsedTime=1.019546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 05:28:59.362678) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:59.363049) ========= echo dd1abe874252e507b825a0a4e1063b0e13578288 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dd1abe874252e507b825a0a4e1063b0e13578288'] 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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dd1abe874252e507b825a0a4e1063b0e13578288 program finished with exit code 0 elapsedTime=0.004712 script_repo_revision: 'dd1abe874252e507b825a0a4e1063b0e13578288' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:59.413895) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:59.414388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:59.425435) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-03-10 05:28:59.425832) ========= /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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:28:59 INFO - MultiFileLogger online at 20160310 05:28:59 in /builds/slave/test 05:28:59 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:28:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:28:59 INFO - {'append_to_log': False, 05:28:59 INFO - 'base_work_dir': '/builds/slave/test', 05:28:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:28:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:28:59 INFO - 'branch': 'Firefox-Non-PGO', 05:28:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:28:59 INFO - 'config_files': ('talos/linux_config.py',), 05:28:59 INFO - 'default_actions': ('clobber', 05:28:59 INFO - 'read-buildbot-config', 05:28:59 INFO - 'download-and-extract', 05:28:59 INFO - 'populate-webroot', 05:28:59 INFO - 'create-virtualenv', 05:28:59 INFO - 'install', 05:28:59 INFO - 'run-tests'), 05:28:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:28:59 INFO - 'download_minidump_stackwalk': True, 05:28:59 INFO - 'download_symbols': 'ondemand', 05:28:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:28:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:28:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:28:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:28:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:28:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:28:59 INFO - 'installer_path': 'installer.exe', 05:28:59 INFO - 'log_level': 'info', 05:28:59 INFO - 'log_name': 'talos', 05:28:59 INFO - 'log_to_console': True, 05:28:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:28:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:28:59 INFO - 'opt_config_files': (), 05:28:59 INFO - 'pip_index': False, 05:28:59 INFO - 'sps_profile': False, 05:28:59 INFO - 'sps_profile_interval': 0, 05:28:59 INFO - 'suite': 'dromaeojs', 05:28:59 INFO - 'system_bits': '32', 05:28:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:28:59 INFO - 'title': 'talos-linux64-ix-001', 05:28:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:28:59 INFO - 'use_talos_json': True, 05:28:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:28:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:28:59 INFO - 'work_dir': 'build'} 05:28:59 INFO - ##### 05:28:59 INFO - ##### Running clobber step. 05:28:59 INFO - ##### 05:28:59 INFO - Running pre-action listener: _resource_record_pre_action 05:28:59 INFO - Running main action method: clobber 05:28:59 INFO - rmtree: /builds/slave/test/build 05:28:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:00 INFO - Running post-action listener: _resource_record_post_action 05:29:00 INFO - ##### 05:29:00 INFO - ##### Running read-buildbot-config step. 05:29:00 INFO - ##### 05:29:00 INFO - Running pre-action listener: _resource_record_pre_action 05:29:00 INFO - Running main action method: read_buildbot_config 05:29:00 INFO - Using buildbot properties: 05:29:00 INFO - { 05:29:00 INFO - "project": "", 05:29:00 INFO - "product": "firefox", 05:29:00 INFO - "script_repo_revision": "production", 05:29:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:29:00 INFO - "repository": "", 05:29:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:29:00 INFO - "buildid": "20160310025316", 05:29:00 INFO - "pgo_build": "False", 05:29:00 INFO - "basedir": "/builds/slave/test", 05:29:00 INFO - "buildnumber": 29, 05:29:00 INFO - "slavename": "talos-linux64-ix-001", 05:29:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:29:00 INFO - "platform": "ubuntu64_hw", 05:29:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:29:00 INFO - "branch": "mozilla-central", 05:29:00 INFO - "repo_path": "mozilla-central", 05:29:00 INFO - "revision": "dd1abe874252e507b825a0a4e1063b0e13578288", 05:29:00 INFO - "stage_platform": "linux64", 05:29:00 INFO - "builduid": "71cdc01cf07e4e06b30287eb71c66d2e", 05:29:00 INFO - "slavebuilddir": "test" 05:29:00 INFO - } 05:29:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:29:00 INFO - Running post-action listener: _resource_record_post_action 05:29:00 INFO - ##### 05:29:00 INFO - ##### Running download-and-extract step. 05:29:00 INFO - ##### 05:29:00 INFO - Running pre-action listener: _resource_record_pre_action 05:29:00 INFO - Running main action method: download_and_extract 05:29:00 INFO - mkdir: /builds/slave/test/build/tests 05:29:00 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:29:00 INFO - https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:29:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:29:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:29:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:08 INFO - Downloaded 1361 bytes. 05:29:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:29:08 INFO - Using the following test package requirements: 05:29:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:29:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:29:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:08 INFO - u'jsshell-linux-x86_64.zip'], 05:29:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:29:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:29:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:29:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:29:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:29:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:29: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:29:08 INFO - https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:29:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:29:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:29:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:10 INFO - Downloaded 22092856 bytes. 05:29:10 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:29:10 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:29:12 INFO - Return code: 0 05:29:12 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:29: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:29:12 INFO - https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:29:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:29:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:29:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:14 INFO - Downloaded 22092856 bytes. 05:29:14 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:29:14 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:29:15 INFO - Return code: 0 05:29: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:29:15 INFO - https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:16 INFO - Downloaded 10845161 bytes. 05:29:16 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:29:16 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:29:16 INFO - Return code: 0 05:29:16 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:29:16 INFO - https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:29:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:29:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:29:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7TTGCzGSEuAlD6O4zTccA/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:29:18 INFO - Downloaded 54427597 bytes. 05:29:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:29:18 INFO - mkdir: /builds/slave/test/properties 05:29:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:18 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:18 INFO - Contents: 05:29:18 INFO - build_url:https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:29:18 INFO - Running post-action listener: _resource_record_post_action 05:29:18 INFO - Running post-action listener: set_extra_try_arguments 05:29:18 INFO - ##### 05:29:18 INFO - ##### Running populate-webroot step. 05:29:18 INFO - ##### 05:29:18 INFO - Running pre-action listener: _resource_record_pre_action 05:29:18 INFO - Running main action method: populate_webroot 05:29:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:29:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:29:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:29:18 INFO - '--tppagecycles', 05:29:18 INFO - '7'], 05:29:18 INFO - 'tests': ['tsvgm']}}, 05:29:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:29:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:29:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:29:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:18 INFO - 'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:18 INFO - 'tests': ['damp', 'tps']}, 05:29:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:18 INFO - 'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['damp', 'tps']}, 05:29:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:29:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:18 INFO - 'other': {'tests': ['a11yr', 05:29:18 INFO - 'ts_paint', 05:29:18 INFO - 'tpaint', 05:29:18 INFO - 'sessionrestore', 05:29:18 INFO - 'sessionrestore_no_auto_restore', 05:29:18 INFO - 'tabpaint']}, 05:29:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['a11yr', 05:29:18 INFO - 'ts_paint', 05:29:18 INFO - 'tpaint', 05:29:18 INFO - 'sessionrestore', 05:29:18 INFO - 'sessionrestore_no_auto_restore', 05:29:18 INFO - 'tabpaint']}, 05:29:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['a11yr', 05:29:18 INFO - 'ts_paint', 05:29:18 INFO - 'tpaint', 05:29:18 INFO - 'sessionrestore', 05:29:18 INFO - 'sessionrestore_no_auto_restore', 05:29:18 INFO - 'tabpaint']}, 05:29:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['a11yr', 05:29:18 INFO - 'ts_paint', 05:29:18 INFO - 'tpaint', 05:29:18 INFO - 'sessionrestore', 05:29:18 INFO - 'sessionrestore_no_auto_restore', 05:29:18 INFO - 'tabpaint']}, 05:29:18 INFO - 'other_l64': {'tests': ['a11yr', 05:29:18 INFO - 'ts_paint', 05:29:18 INFO - 'tpaint', 05:29:18 INFO - 'sessionrestore', 05:29:18 INFO - 'sessionrestore_no_auto_restore', 05:29:18 INFO - 'tabpaint']}, 05:29:18 INFO - 'other_nol64': {'tests': ['a11yr', 05:29:18 INFO - 'ts_paint', 05:29:18 INFO - 'tpaint', 05:29:18 INFO - 'sessionrestore', 05:29:18 INFO - 'sessionrestore_no_auto_restore', 05:29:18 INFO - 'tabpaint']}, 05:29:18 INFO - 'svgr': {'tests': ['tsvgx', 05:29:18 INFO - 'tsvgr_opacity', 05:29:18 INFO - 'tart', 05:29:18 INFO - 'tscrollx', 05:29:18 INFO - 'cart']}, 05:29:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['tsvgx', 05:29:18 INFO - 'tsvgr_opacity', 05:29:18 INFO - 'tart', 05:29:18 INFO - 'tscrollx', 05:29:18 INFO - 'cart']}, 05:29:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:18 INFO - 'tests': ['tp5o']}, 05:29:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:18 INFO - 'talos_options': ['--e10s'], 05:29:18 INFO - 'tests': ['tp5o']}, 05:29:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:18 INFO - 'talos_options': ['--xperf_path', 05:29:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:18 INFO - 'tests': ['tp5n']}, 05:29:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:18 INFO - 'talos_options': ['--e10s', 05:29:18 INFO - '--xperf_path', 05:29:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:18 INFO - 'tests': ['tp5n']}}, 05:29:18 INFO - 'talos.zip': {'path': '', 05:29:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:29:18 INFO - Running post-action listener: _resource_record_post_action 05:29:18 INFO - ##### 05:29:18 INFO - ##### Running create-virtualenv step. 05:29:18 INFO - ##### 05:29:18 INFO - Running pre-action listener: _resource_record_pre_action 05:29:18 INFO - Running main action method: create_virtualenv 05:29:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:18 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:29:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:29:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:19 INFO - Using real prefix '/usr' 05:29:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:21 INFO - Installing pip.................done. 05:29:21 INFO - Return code: 0 05:29:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:29:21 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:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:21 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:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:21 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 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:21 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:29:21 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:29:21 INFO - Using env: {'DISPLAY': ':0', 05:29:21 INFO - 'HOME': '/home/cltbld', 05:29:21 INFO - 'LANG': 'en_US.UTF-8', 05:29:21 INFO - 'LANGUAGE': 'en_US:en', 05:29:21 INFO - 'LOGNAME': 'cltbld', 05:29:21 INFO - 'MAIL': '/var/mail/cltbld', 05:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:21 INFO - 'MOZ_NO_REMOTE': '1', 05:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:21 INFO - 'NO_EM_RESTART': '1', 05:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:21 INFO - 'PWD': '/builds/slave/test', 05:29:21 INFO - 'SHELL': '/bin/bash', 05:29:21 INFO - 'SHLVL': '1', 05:29:21 INFO - 'TERM': 'linux', 05:29:21 INFO - 'TMOUT': '86400', 05:29:21 INFO - 'USER': 'cltbld', 05:29:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:21 INFO - '_': '/tools/buildbot/bin/python'} 05:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:21 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:29:21 INFO - Cleaning up... 05:29:21 INFO - Return code: 0 05:29:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:29:21 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:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:21 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:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:21 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 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:21 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:29:21 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:29:21 INFO - Using env: {'DISPLAY': ':0', 05:29:21 INFO - 'HOME': '/home/cltbld', 05:29:21 INFO - 'LANG': 'en_US.UTF-8', 05:29:21 INFO - 'LANGUAGE': 'en_US:en', 05:29:21 INFO - 'LOGNAME': 'cltbld', 05:29:21 INFO - 'MAIL': '/var/mail/cltbld', 05:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:21 INFO - 'MOZ_NO_REMOTE': '1', 05:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:21 INFO - 'NO_EM_RESTART': '1', 05:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:21 INFO - 'PWD': '/builds/slave/test', 05:29:21 INFO - 'SHELL': '/bin/bash', 05:29:21 INFO - 'SHLVL': '1', 05:29:21 INFO - 'TERM': 'linux', 05:29:21 INFO - 'TMOUT': '86400', 05:29:21 INFO - 'USER': 'cltbld', 05:29:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:21 INFO - '_': '/tools/buildbot/bin/python'} 05:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:22 INFO - Downloading/unpacking psutil>=0.7.1 05:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:23 INFO - Installing collected packages: psutil 05:29:23 INFO - Running setup.py install for psutil 05:29:24 INFO - building 'psutil._psutil_linux' extension 05:29:24 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:29:24 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:29:24 INFO - building 'psutil._psutil_posix' extension 05:29:24 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:29:24 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:29:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:24 INFO - Successfully installed psutil 05:29:24 INFO - Cleaning up... 05:29:24 INFO - Return code: 0 05:29:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:29:24 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:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:24 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:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:24 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 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:24 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:29:24 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:29:24 INFO - Using env: {'DISPLAY': ':0', 05:29:24 INFO - 'HOME': '/home/cltbld', 05:29:24 INFO - 'LANG': 'en_US.UTF-8', 05:29:24 INFO - 'LANGUAGE': 'en_US:en', 05:29:24 INFO - 'LOGNAME': 'cltbld', 05:29:24 INFO - 'MAIL': '/var/mail/cltbld', 05:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:24 INFO - 'MOZ_NO_REMOTE': '1', 05:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:24 INFO - 'NO_EM_RESTART': '1', 05:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:24 INFO - 'PWD': '/builds/slave/test', 05:29:24 INFO - 'SHELL': '/bin/bash', 05:29:24 INFO - 'SHLVL': '1', 05:29:24 INFO - 'TERM': 'linux', 05:29:24 INFO - 'TMOUT': '86400', 05:29:24 INFO - 'USER': 'cltbld', 05:29:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:24 INFO - '_': '/tools/buildbot/bin/python'} 05:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:29:24 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:29:24 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:29:24 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:29:24 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:29:24 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:29:24 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:29:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:26 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:29:26 INFO - Installing collected packages: mozsystemmonitor 05:29:26 INFO - Running setup.py install for mozsystemmonitor 05:29:26 INFO - Successfully installed mozsystemmonitor 05:29:26 INFO - Cleaning up... 05:29:26 INFO - Return code: 0 05:29:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:26 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 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:26 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:29:26 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:29:26 INFO - Using env: {'DISPLAY': ':0', 05:29:26 INFO - 'HOME': '/home/cltbld', 05:29:26 INFO - 'LANG': 'en_US.UTF-8', 05:29:26 INFO - 'LANGUAGE': 'en_US:en', 05:29:26 INFO - 'LOGNAME': 'cltbld', 05:29:26 INFO - 'MAIL': '/var/mail/cltbld', 05:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:26 INFO - 'MOZ_NO_REMOTE': '1', 05:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:26 INFO - 'NO_EM_RESTART': '1', 05:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:26 INFO - 'PWD': '/builds/slave/test', 05:29:26 INFO - 'SHELL': '/bin/bash', 05:29:26 INFO - 'SHLVL': '1', 05:29:26 INFO - 'TERM': 'linux', 05:29:26 INFO - 'TMOUT': '86400', 05:29:26 INFO - 'USER': 'cltbld', 05:29:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:26 INFO - '_': '/tools/buildbot/bin/python'} 05:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:29:26 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:29:26 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:29:26 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:29:26 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:29:26 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:29:26 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:29:28 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:29:28 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:29:28 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:29:28 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:29:28 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:29:28 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:29:28 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:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:29:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:29:29 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:29:29 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:29:29 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:29:29 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:29:29 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:29:29 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:29:29 INFO - Downloading docopt-0.6.1.tar.gz 05:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:29 INFO - Running setup.py install for blobuploader 05:29:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:29:29 INFO - Running setup.py install for requests 05:29:29 INFO - Running setup.py install for docopt 05:29:30 INFO - Successfully installed blobuploader requests docopt 05:29:30 INFO - Cleaning up... 05:29:30 INFO - Return code: 0 05:29:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29: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:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:30 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 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:30 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:29:30 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:29:30 INFO - Using env: {'DISPLAY': ':0', 05:29:30 INFO - 'HOME': '/home/cltbld', 05:29:30 INFO - 'LANG': 'en_US.UTF-8', 05:29:30 INFO - 'LANGUAGE': 'en_US:en', 05:29:30 INFO - 'LOGNAME': 'cltbld', 05:29:30 INFO - 'MAIL': '/var/mail/cltbld', 05:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:30 INFO - 'MOZ_NO_REMOTE': '1', 05:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:30 INFO - 'NO_EM_RESTART': '1', 05:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:30 INFO - 'PWD': '/builds/slave/test', 05:29:30 INFO - 'SHELL': '/bin/bash', 05:29:30 INFO - 'SHLVL': '1', 05:29:30 INFO - 'TERM': 'linux', 05:29:30 INFO - 'TMOUT': '86400', 05:29:30 INFO - 'USER': 'cltbld', 05:29:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:30 INFO - '_': '/tools/buildbot/bin/python'} 05:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:30 INFO - Running setup.py (path:/tmp/pip-6INK1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:30 INFO - Running setup.py (path:/tmp/pip-ifXG1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:30 INFO - Running setup.py (path:/tmp/pip-xj4xhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:30 INFO - Running setup.py (path:/tmp/pip-X6vGcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:30 INFO - Running setup.py (path:/tmp/pip-wOF2KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:30 INFO - Running setup.py (path:/tmp/pip-YDZXno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:30 INFO - Running setup.py (path:/tmp/pip-lXitTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:30 INFO - Running setup.py (path:/tmp/pip-uGjBUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:30 INFO - Running setup.py (path:/tmp/pip-d05iak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:30 INFO - Running setup.py (path:/tmp/pip-mqxKzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:31 INFO - Running setup.py (path:/tmp/pip-mxpAe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:31 INFO - Running setup.py (path:/tmp/pip-QJTJBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:31 INFO - Running setup.py (path:/tmp/pip-w9wKKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:31 INFO - Running setup.py (path:/tmp/pip-Tbt8Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:31 INFO - Running setup.py (path:/tmp/pip-ePLYJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:31 INFO - Running setup.py (path:/tmp/pip-M4xYZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:31 INFO - Running setup.py (path:/tmp/pip-JMN5TQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:29:31 INFO - Running setup.py install for manifestparser 05:29:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:29:31 INFO - Running setup.py install for mozcrash 05:29:31 INFO - Running setup.py install for mozdebug 05:29:31 INFO - Running setup.py install for mozdevice 05:29:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:29:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:29:31 INFO - Running setup.py install for mozfile 05:29:32 INFO - Running setup.py install for mozhttpd 05:29:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Running setup.py install for mozinfo 05:29:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Running setup.py install for mozInstall 05:29:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Running setup.py install for mozleak 05:29:32 INFO - Running setup.py install for mozlog 05:29:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Running setup.py install for moznetwork 05:29:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Running setup.py install for mozprocess 05:29:32 INFO - Running setup.py install for mozprofile 05:29:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Running setup.py install for mozrunner 05:29:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:29:32 INFO - Running setup.py install for mozscreenshot 05:29:33 INFO - Running setup.py install for moztest 05:29:33 INFO - Running setup.py install for mozversion 05:29:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:29:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:29:33 INFO - Cleaning up... 05:29:33 INFO - Return code: 0 05:29:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:33 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:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:33 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:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:33 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 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:33 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:29:33 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:29:33 INFO - Using env: {'DISPLAY': ':0', 05:29:33 INFO - 'HOME': '/home/cltbld', 05:29:33 INFO - 'LANG': 'en_US.UTF-8', 05:29:33 INFO - 'LANGUAGE': 'en_US:en', 05:29:33 INFO - 'LOGNAME': 'cltbld', 05:29:33 INFO - 'MAIL': '/var/mail/cltbld', 05:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:33 INFO - 'MOZ_NO_REMOTE': '1', 05:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:33 INFO - 'NO_EM_RESTART': '1', 05:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:33 INFO - 'PWD': '/builds/slave/test', 05:29:33 INFO - 'SHELL': '/bin/bash', 05:29:33 INFO - 'SHLVL': '1', 05:29:33 INFO - 'TERM': 'linux', 05:29:33 INFO - 'TMOUT': '86400', 05:29:33 INFO - 'USER': 'cltbld', 05:29:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:33 INFO - '_': '/tools/buildbot/bin/python'} 05:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:33 INFO - Running setup.py (path:/tmp/pip-l839wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:33 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:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:33 INFO - Running setup.py (path:/tmp/pip-ynaRI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:33 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:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:33 INFO - Running setup.py (path:/tmp/pip-GyfLTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:33 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:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:33 INFO - Running setup.py (path:/tmp/pip-NeNlIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:33 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:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:33 INFO - Running setup.py (path:/tmp/pip-TiEiD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:33 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:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:33 INFO - Running setup.py (path:/tmp/pip-Hn8V3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:33 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:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:33 INFO - Running setup.py (path:/tmp/pip-akDbMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:33 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:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:33 INFO - Running setup.py (path:/tmp/pip-7CWnLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:34 INFO - Running setup.py (path:/tmp/pip-V1xHEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:34 INFO - Running setup.py (path:/tmp/pip-8mU3cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:34 INFO - Running setup.py (path:/tmp/pip-xXeXTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:34 INFO - Running setup.py (path:/tmp/pip-JKvrmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:34 INFO - Running setup.py (path:/tmp/pip-5qWf_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:34 INFO - Running setup.py (path:/tmp/pip-ieMc3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:34 INFO - Running setup.py (path:/tmp/pip-nco54W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:34 INFO - Running setup.py (path:/tmp/pip-Tsockh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:34 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:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:34 INFO - Running setup.py (path:/tmp/pip-hsvszJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:34 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:29:34 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:29:34 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:29:34 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:29:34 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:29:34 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:29:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:34 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:29:34 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:29:34 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:29:34 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:29:34 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:29:34 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:29:36 INFO - Downloading blessings-1.6.tar.gz 05:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:29:36 INFO - Installing collected packages: blessings 05:29:36 INFO - Running setup.py install for blessings 05:29:36 INFO - Successfully installed blessings 05:29:36 INFO - Cleaning up... 05:29:36 INFO - Return code: 0 05:29:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:29:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:36 INFO - Reading from file tmpfile_stdout 05:29:36 INFO - Current package versions: 05:29:36 INFO - argparse == 1.2.1 05:29:36 INFO - blessings == 1.6 05:29:36 INFO - blobuploader == 1.2.4 05:29:36 INFO - docopt == 0.6.1 05:29:36 INFO - manifestparser == 1.1 05:29:36 INFO - mozInstall == 1.12 05:29:36 INFO - mozcrash == 0.17 05:29:36 INFO - mozdebug == 0.1 05:29:36 INFO - mozdevice == 0.48 05:29:36 INFO - mozfile == 1.2 05:29:36 INFO - mozhttpd == 0.7 05:29:36 INFO - mozinfo == 0.9 05:29:36 INFO - mozleak == 0.1 05:29:36 INFO - mozlog == 3.1 05:29:36 INFO - moznetwork == 0.27 05:29:36 INFO - mozprocess == 0.22 05:29:36 INFO - mozprofile == 0.28 05:29:36 INFO - mozrunner == 6.11 05:29:36 INFO - mozscreenshot == 0.1 05:29:36 INFO - mozsystemmonitor == 0.0 05:29:36 INFO - moztest == 0.7 05:29:36 INFO - mozversion == 1.4 05:29:36 INFO - psutil == 3.1.1 05:29:36 INFO - requests == 1.2.3 05:29:36 INFO - wsgiref == 0.1.2 05:29:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:36 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 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:36 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:29:36 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:29:36 INFO - Using env: {'DISPLAY': ':0', 05:29:36 INFO - 'HOME': '/home/cltbld', 05:29:36 INFO - 'LANG': 'en_US.UTF-8', 05:29:36 INFO - 'LANGUAGE': 'en_US:en', 05:29:36 INFO - 'LOGNAME': 'cltbld', 05:29:36 INFO - 'MAIL': '/var/mail/cltbld', 05:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:36 INFO - 'MOZ_NO_REMOTE': '1', 05:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:36 INFO - 'NO_EM_RESTART': '1', 05:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:36 INFO - 'PWD': '/builds/slave/test', 05:29:36 INFO - 'SHELL': '/bin/bash', 05:29:36 INFO - 'SHLVL': '1', 05:29:36 INFO - 'TERM': 'linux', 05:29:36 INFO - 'TMOUT': '86400', 05:29:36 INFO - 'USER': 'cltbld', 05:29:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:36 INFO - '_': '/tools/buildbot/bin/python'} 05:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 INFO - Cleaning up... 05:29:37 INFO - Return code: 0 05:29:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:29:37 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:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:37 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:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:37 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 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:37 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:29:37 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:29:37 INFO - Using env: {'DISPLAY': ':0', 05:29:37 INFO - 'HOME': '/home/cltbld', 05:29:37 INFO - 'LANG': 'en_US.UTF-8', 05:29:37 INFO - 'LANGUAGE': 'en_US:en', 05:29:37 INFO - 'LOGNAME': 'cltbld', 05:29:37 INFO - 'MAIL': '/var/mail/cltbld', 05:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:37 INFO - 'MOZ_NO_REMOTE': '1', 05:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:37 INFO - 'NO_EM_RESTART': '1', 05:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:37 INFO - 'PWD': '/builds/slave/test', 05:29:37 INFO - 'SHELL': '/bin/bash', 05:29:37 INFO - 'SHLVL': '1', 05:29:37 INFO - 'TERM': 'linux', 05:29:37 INFO - 'TMOUT': '86400', 05:29:37 INFO - 'USER': 'cltbld', 05:29:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:37 INFO - '_': '/tools/buildbot/bin/python'} 05:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:37 INFO - Downloading/unpacking jsonschema 05:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:29:39 INFO - Downloading/unpacking functools32 (from jsonschema) 05:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:29:39 INFO - warning: no files found matching '*.txt' 05:29:39 INFO - no previously-included directories found matching 'build' 05:29:39 INFO - no previously-included directories found matching 'dist' 05:29:39 INFO - no previously-included directories found matching '.git*' 05:29:39 INFO - Installing collected packages: jsonschema, functools32 05:29:39 INFO - Running setup.py install for functools32 05:29:39 INFO - warning: no files found matching '*.txt' 05:29:39 INFO - no previously-included directories found matching 'build' 05:29:39 INFO - no previously-included directories found matching 'dist' 05:29:39 INFO - no previously-included directories found matching '.git*' 05:29:39 INFO - Successfully installed jsonschema functools32 05:29:39 INFO - Cleaning up... 05:29:39 INFO - Return code: 0 05:29:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44ecf9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', '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:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:29:39 INFO - Using env: {'DISPLAY': ':0', 05:29:39 INFO - 'HOME': '/home/cltbld', 05:29:39 INFO - 'LANG': 'en_US.UTF-8', 05:29:39 INFO - 'LANGUAGE': 'en_US:en', 05:29:39 INFO - 'LOGNAME': 'cltbld', 05:29:39 INFO - 'MAIL': '/var/mail/cltbld', 05:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:39 INFO - 'MOZ_NO_REMOTE': '1', 05:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:39 INFO - 'NO_EM_RESTART': '1', 05:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:39 INFO - 'PWD': '/builds/slave/test', 05:29:39 INFO - 'SHELL': '/bin/bash', 05:29:39 INFO - 'SHLVL': '1', 05:29:39 INFO - 'TERM': 'linux', 05:29:39 INFO - 'TMOUT': '86400', 05:29:39 INFO - 'USER': 'cltbld', 05:29:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:39 INFO - '_': '/tools/buildbot/bin/python'} 05:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:39 INFO - Downloading/unpacking flake8 05:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:29:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:29:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:29:42 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:29:42 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:29:42 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:29:42 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:29:42 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:29:42 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:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:29:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:29:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:29:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:29:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:29:42 INFO - no previously-included directories found matching 'docs/_build' 05:29:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:29:42 INFO - Running setup.py install for pep8 05:29:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:29:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:29:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:29:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:29:42 INFO - no previously-included directories found matching 'docs/_build' 05:29:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:29:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:29:42 INFO - Cleaning up... 05:29:42 INFO - Return code: 0 05:29:42 INFO - Running post-action listener: _resource_record_post_action 05:29:42 INFO - Running post-action listener: _start_resource_monitoring 05:29:42 INFO - Starting resource monitoring. 05:29:42 INFO - ##### 05:29:42 INFO - ##### Running install step. 05:29:42 INFO - ##### 05:29:42 INFO - Running pre-action listener: _resource_record_pre_action 05:29:42 INFO - Running main action method: install 05:29:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:42 INFO - Reading from file tmpfile_stdout 05:29:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:29:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:29:43 INFO - Reading from file tmpfile_stdout 05:29:43 INFO - Output received: 05:29:43 INFO - Usage: mozinstall [options] installer 05:29:43 INFO - Options: 05:29:43 INFO - -h, --help show this help message and exit 05:29:43 INFO - -d DEST, --destination=DEST 05:29:43 INFO - Directory to install application into. [default: 05:29:43 INFO - "/builds/slave/test"] 05:29:43 INFO - --app=APP Application being installed. [default: firefox] 05:29:43 INFO - mkdir: /builds/slave/test/build/application 05:29:43 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:29:43 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:29:58 INFO - Reading from file tmpfile_stdout 05:29:58 INFO - Output received: 05:29:58 INFO - /builds/slave/test/build/application/firefox/firefox 05:29:58 INFO - Running post-action listener: _resource_record_post_action 05:29:58 INFO - ##### 05:29:58 INFO - ##### Running run-tests step. 05:29:58 INFO - ##### 05:29:58 INFO - Running pre-action listener: _resource_record_pre_action 05:29:58 INFO - Running main action method: run_tests 05:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:29:58 INFO - Python 2.7.3 05:29:58 INFO - Return code: 0 05:29:58 INFO - grabbing minidump binary from tooltool 05:29:58 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:29:58 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 0x2ab3160>, '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 0x2ab4060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab44f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:29:58 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:29:58 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:29:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:58 INFO - Return code: 0 05:29:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:29:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:29:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:29:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:29:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:29:59 INFO - Return code: 0 05:29:59 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/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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:29:59 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/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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:29:59 INFO - Using env: {'DISPLAY': ':0', 05:29:59 INFO - 'HOME': '/home/cltbld', 05:29:59 INFO - 'LANG': 'en_US.UTF-8', 05:29:59 INFO - 'LANGUAGE': 'en_US:en', 05:29:59 INFO - 'LOGNAME': 'cltbld', 05:29:59 INFO - 'MAIL': '/var/mail/cltbld', 05:29:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:29:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:59 INFO - 'MOZ_NO_REMOTE': '1', 05:29:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:59 INFO - 'NO_EM_RESTART': '1', 05:29:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:59 INFO - 'PWD': '/builds/slave/test', 05:29:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:29:59 INFO - 'SHELL': '/bin/bash', 05:29:59 INFO - 'SHLVL': '1', 05:29:59 INFO - 'TERM': 'linux', 05:29:59 INFO - 'TMOUT': '86400', 05:29:59 INFO - 'USER': 'cltbld', 05:29:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907', 05:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:59 INFO - '_': '/tools/buildbot/bin/python'} 05:29:59 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/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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:30:00 INFO - mozversion application_buildid: 20160310025316 05:30:00 INFO - mozversion application_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 05:30:00 INFO - mozversion application_display_name: Nightly 05:30:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:00 INFO - mozversion application_name: Firefox 05:30:00 INFO - mozversion application_remotingname: firefox 05:30:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:30:00 INFO - mozversion application_vendor: Mozilla 05:30:00 INFO - mozversion application_version: 48.0a1 05:30:00 INFO - mozversion platform_buildid: 20160310025316 05:30:00 INFO - mozversion platform_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 05:30:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:30:00 INFO - mozversion platform_version: 48.0a1 05:30:00 INFO - using testdate: 1457616600 05:30:00 INFO - actual date: 1457616600 05:30:00 INFO - starting webserver on 'localhost:41755' 05:30:00 INFO - SUITE-START | Running 2 tests 05:30:00 INFO - TEST-START | dromaeo_css 05:30:00 INFO - operating with platform_type : linux_ 05:30:00 INFO - Initialising browser for dromaeo_css test... 05:30:00 INFO - TEST-INFO | started process 26465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNAoWK5/profile http://localhost:41755/getInfo.html) 05:30:04 INFO - PROCESS | 26465 | __metrics Screen width/height:1600/1200 05:30:04 INFO - PROCESS | 26465 | colorDepth:24 05:30:04 INFO - PROCESS | 26465 | Browser inner width/height: 1024/697 05:30:04 INFO - PROCESS | 26465 | __metrics 05:30:05 ERROR - PROCESS | 26465 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:30:06 INFO - TEST-INFO | 26465: exit 0 05:30:06 INFO - Browser initialized. 05:30:06 INFO - Running cycle 1/1 for dromaeo_css test... 05:30:06 INFO - TEST-INFO | started process 26559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNAoWK5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:18 INFO - PROCESS | 26559 | RSS: Main: 154927104 05:30:18 INFO - PROCESS | 26559 | 05:31:09 INFO - PROCESS | 26559 | 1457616669844 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:33:21 INFO - PROCESS | 26559 | Cycle 1(1): loaded http://localhost:41755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41755/tests/dromaeo/cssquery-ext.html) 05:33:22 INFO - PROCESS | 26559 | RSS: Main: 236838912 05:33:22 INFO - PROCESS | 26559 | 05:36:24 INFO - PROCESS | 26559 | Cycle 1(1): loaded http://localhost:41755/tests/dromaeo/cssquery-ext.html (next: http://localhost:41755/tests/dromaeo/cssquery-jquery.html) 05:36:25 INFO - PROCESS | 26559 | RSS: Main: 240427008 05:36:25 INFO - PROCESS | 26559 | 05:39:27 INFO - PROCESS | 26559 | Cycle 1(1): loaded http://localhost:41755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41755/tests/dromaeo/cssquery-mootools.html) 05:39:27 INFO - PROCESS | 26559 | RSS: Main: 231591936 05:39:27 INFO - PROCESS | 26559 | 05:42:29 INFO - PROCESS | 26559 | Cycle 1(1): loaded http://localhost:41755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41755/tests/dromaeo/cssquery-prototype.html) 05:42:30 INFO - PROCESS | 26559 | RSS: Main: 204488704 05:42:30 INFO - PROCESS | 26559 | 05:45:32 INFO - PROCESS | 26559 | Cycle 1(1): loaded http://localhost:41755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41755/tests/dromaeo/cssquery-yui.html) 05:45:33 INFO - PROCESS | 26559 | RSS: Main: 197066752 05:45:33 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | Cycle 1(1): loaded http://localhost:41755/tests/dromaeo/cssquery-yui.html (next: http://localhost:41755/tests/dromaeo/cssquery-dojo.html) 05:48:36 INFO - PROCESS | 26559 | RSS: Main: 269799424 05:48:36 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | __start_tp_report 05:48:36 INFO - PROCESS | 26559 | _x_x_mozilla_page_load 05:48:36 INFO - PROCESS | 26559 | _x_x_mozilla_page_load_details 05:48:36 INFO - PROCESS | 26559 | |i|pagename|runs| 05:48:36 INFO - PROCESS | 26559 | |0;dojo.html;2562.7693507584313;2638.116231062594;2643.101345542515;2651.2443953473253;2675.464907018596;4435.578620031092;4488.685791994558;4492.213862574053;4520.367148599191;4521.457425108983;4491.056878055604;4542.386777784998;4542.409486766724;4549.4768101668315;4630.490646028942;4155.272827255233;4179.770112643803;4184.121334519755;4197.244495990721;4297.720648157875;4069.4302797608357;4240.5547417521175;4274.102438487906;4280.957190428103;4291.892702682427;4158.064435502018;4180.916381672349;4188.602082802129;4212.094399704079;4242.4272723182285;4170.145120250371;4171.895702607429;4174.582541745801;4197.307444271692;4221.535631080578;4111.198316328318;4143.316352801784;4169.874903752892;4181.351890456984;4213.1573685262765;4444.911101777979;4474.82100715971;4506.571875671806;4524;4526.4794548627;4772.451168115676;4792.544708252745;4793.616510679172;4799.496052914464;4832.299316599108;4693.366395536593;4809.1343558159515;4818.084563932842;4824.951750482485;4868.829590964299;4520.11857687751;4541.477730061019;4558;4591.357209990638;4595.356650068926;4873.975630121827;4880.633952453581;4882;4883.194272944996;4920.138975679241;4654.697444666086;4687.789049492781;4691.507391723888;4740.762961851894;4748.406449193851;4852.660313778072;4871.464138944784;4872.610191184696;4891.461939186686;4915.754212289371;4768.61851051915;4800.567948884547;4805.975970120127;4820.060088282751;4858.489858564871;4657.930131048037;4780.737059461763;4797.352357431771;4840.685355451885;4866.172750632401;4010.979945100256;4025.677945764332;4035.596440355941;4057.2494088593703;4058.228936502055;3569.428891377419;3570.178858862424;3574.3566158091794;3591.748577599595;3616.782993020427;4077.1845630873945;4109.856155034559;4149.854755083557;4158.293090174678;4203.369494575777;4801.855944321676;4804.783784729696;4808.783604737795;4827.734474603931;4843.903121937541;4153.127843152912;4155.10665206982;4169.457970463881;4179.832806687759;4200.789960501963;4234.87295381139;4247.235497610398;4297.892552686208;4308.9353659695125;4314.482262128565;4467.865964021084;4470.1059788041875;4477;4498.280275155959;4514.277715565494;4715.834945776881;4716.787744551435;4726.6691331607835;4727.196376615915;4753.83361582343;4471;4483.887902802456;4559.635229181591;4625.05186436773;4635.374224479652;4715.693479923794;4720.268358404453;4729.479757226633;4734.289856521549;4746.667733258639;4764.78558464863;4784.784684689267;4785.234362501983;4802.039592081667;4827.589654879374;4577.038821847449;4625.953740462553;4677.508861569486;4700.435947686163;4718.528147185254;4645.67480276391;4650.767461626972;4666.650001249987;4667.97304592989;4694.530546945278;4449.621782148424;4583.1062942727185;4586.8165273388695;4592.311153327028;4624.9768751156025;4719.3628860103445;4765.928511072268;4767.141914455431;4800.975995120002;4803.183458811941;4529.300189677627;4563.247064234364;4564.589186973189;4566.748828814314;4600.401947746772 05:48:36 INFO - PROCESS | 26559 | |1;ext.html;479.50371365636573;488.10676462074406;488.7165444042453;494.3400560252063;511.57794819274096;24536.509269814593;33089.50365744516;33283.66716332836;33381.33237335255;33431;36578.26843463129;36864.631353686455;37031.6671499565;37096;37136.628633713655;6900.896486552706;7609.3532049775695;7811.648475818573;7815.101263354702;9547.856782148274;9732.172765314921;9877.308588398815;9886.110250077492;9892.802143957117;9893.356931799446;9870.161036311922;9968.501574921262;9968.551415186297;9969.750756231117;9973.152282055999;9780.804383912318;9884.357516761387;9892.802143957153;9898;9898.752531186707;9615.375000625007;10082.69751907444;10092.091711745978;10105.646302379455;10106.646267380607;38315.425268620995;38750.224995499935;38751.806240968894;38774.80612596947;38782;2911.8689658965186;3067.884792512029;3504.229069604683;3544.2557063016798;3561.198730285691;28105.718942810516;28598.85700571484;28632.14103576896;28694.426111477864;29041.41917161666;3453.3438646657055;3479.6868281854754;3601.5318008658705;3623.184783423735;3634.800085995269;224133;224871;226309;226394;227844;38669.48648337849;39137.21725565473;39183.608163918;53967.46032539703;54381.72809135929;36682;36739.4489082664;36866.26267474636;36881.89354319375;36897.44653830195;12172.2696638202;13322.20066795976;13475.797863032063;13482.325883705775;13493.865061349457;10242.53908574116;10519.789604208027;10576.841347379795;10581.894181058246;10596.364218146937;13012;13168.802467962989;13179.60461186166;13201.20792752438;13333.20000799955;5492.5605951524585;5536.529395001389;5555.8888822223325;5559.77760889568;5612.831615051555;802.8233788566506;805.9919400805917;863.7926897544544;953.2421724728857;976.3312131190157;26324.60513092305;28572.71427285742;29354.706452935625;30105.397892042038;30114.397712045637;913.4154141349542;926.2312280806914;934.1079269297804;960.865478832964;1093.797647435227;13698.931505342409;14100.435982560788;14381.352839122264;14391.78412323816;14395.496157634641;303495;305669;308368;310782;312198;47382.76308618435;47852.7607361961;47871.28193077107;47883;48032.5196748035;1149.316156886651;1194.978293559012;1220.6033039262452;1238.2446707508414;1247.114548670436;23936;24801.50396992086;26280.29178103417;27073.052443164393;27077.1876843695;35971;36267.09332266715;36342;36751;36767.63232367642;188485;189929;190032;190203;190221;23977.28068157958;28091.71908280891;28337.29156771097;28373.858130709214;28654.71345286604;33294;40711.38932916068;41721.58278417177;41861.1627767449;42264.577354227295;30759.384812304077;32452.837735812114;32534.511982320757;33909.49135763015;34214.31571368608;33515.4972675415;33926;33972.49041264432;34082.82958585191;34251.657483424846;33243.66756332406;33561.16097097592;34041.48937765886;34097.65902340945;34126.65873341235;29613.407731845673;30582.235444114074;30799.2300192497;30799.692003079683;30878.845605772727;23692.407689807893;23906.521869562162;24098.87950560236;24205.757942421056;24314.392140196636 05:48:36 INFO - PROCESS | 26559 | |2;jquery.html;314.2834337710021;322.3778108251076;332.3154742357479;336.9022983334833;338.1023382918353;14549.78175327371;15110.395584176633;15566.922165389156;15572.377104915819;15623.14072726001;15872.206389680527;15917.84082159178;16152;16159.83840161598;16288.918555407236;4830.782614782334;5034.0686972910125;5064.215046667772;5081.79672813087;5088.389393272812;4746.406699162605;4934.605231581465;4935.333729946447;4938.012397520492;4949.975250123744;4813.879653008667;4877.609791216694;4902.7058376497525;4903.583195428393;4917.188663870457;5116.258142569307;5128.974355128219;5151.716655583941;5165.896682066356;5168.147255702805;4924.236743304794;4939.925901111486;4945.554900058976;4947.307376967227;4947.9505204947845;11564.248323859007;11587.884121158764;11596.246243994114;11599.362035088066;12293.69265768354;1659.6514731906314;1663.991680041592;1724.922378492971;1760.3662681434673;1843.3271855772546;8426.410151289412;8577.785555361104;8751.906011748531;8812.779680508038;9127.817443651156;1734.80917099119;1746.6594014167242;1757.6045389787323;1777.6622441736029;1784.3843873863495;55163;56645;56939;58042;59110;8869.113088691209;9059.547022648841;9874.901250987541;9887;10034.046765557261;12677.366131693378;12839.358032098358;12849.4217760201;12874.356282185854;12878.549250776177;7058;7139.214686384494;7170.139583250043;7299.19708832028;7300.817479563053;6893.448524118058;6909;6928.653567321614;7034.824129396704;7064.470164737665;4138.379243113557;4193.475815523059;4229.365595160751;4242.151569686075;4301.677374196947;1557.524954888747;1598.3686443854613;1608.5817687401359;1619.5627180661156;1641.9261133249033;845.2561745663777;859.7678626770737;863.6459051788736;864.4381152251087;875.6847534887436;14665.706685866437;15210.771838422432;15229.771553426708;15243.314050867515;15553.611159720871;777.1839568453101;779.38818027849;806.3589446390134;818.9467684600601;929.3958926697566;8574.78563035929;8812.647494100293;8846.646134154691;8880.644774208959;9030.142136497023;347468;369604;373632;374072;374502;65054.674726626065;68379.65810170917;68431.65784171048;68503.3149668507;69444.30555694379;858.4548811504615;875.4309698695771;939.9295052870925;943.4763706143019;946.0303189230956;13557.728845423233;13825.654358641115;13888.722225555635;13932.860671393157;14102.717945641234;30314;30824.69175308218;31487.308788055827;32053.839730801195;32107.678923211402;40471.79764101161;41583.168336632494;41596.792016039726;42980.35529466998;44015;6804.149481314836;7104.502684812013;7136.0723105995885;7318.487705860539;7336.449766267658;8080.757577272691;10513.474326283807;10965.780684386427;11296.943515282699;11342.943285283522;9320.860187097063;9527.952360238154;9626.037396260317;9636.614535418505;9954.601815927283;9377.296702747184;9498.95250523743;9636.855447168158;9716.3198576099;9820.754481138028;9555.665551705657;9720.708378748648;9858.556364963737;9936.652217172365;9950.046583543102;6556.475481961527;6572.638504882086;6815.795526134224;6877.071595334766;7155.892661609976;8597.656093756179;8641.697540586048;8664.436811607226;8812.206901378906;8863.202311791969 05:48:36 INFO - PROCESS | 26559 | |3;mootools.html;1234.1299383934327;1437.5256165465394;1449.384011794987;1612.685526322367;1807.0332372180885;6409.230892292926;7265.418766498674;7442.255774422555;7447.925520744791;7451.590162541058;7200.279972002797;7345.559266444017;7361.337479626833;7371.262873712626;7384.076990376203;1822.8177182281797;2082.187946700788;2135.1032566322183;2161.9027143778567;2197.307848027874;2184.868907865533;2231.163313757341;2232.441889527618;2235.1282999630075;2235.552889422122;2119.4913220826966;2183.836212284077;2187.289131032413;2188.803007729304;2189.4964158243615;2130.6803979403057;2152.0315857863948;2154.8168405685537;2164.4588852786806;2168.9240876569243;2151.3653472225733;2175.227794133076;2183.094015983365;2186.759456459788;2187.671849222613;7352.742654007137;7398;7419.777406677808;7429;7434.033575635132;4328.069465065026;4451.1765323415275;4456.866294011184;4465.263231566788;4472.485664148632;2836.390176112125;2836.7305106014896;2897.4350001749667;2902.1873875314946;3001.564773107909;934.5327336331834;936.5317341329335;941.7975135345933;948.2745699539857;968.2979839616293;10137.239707021929;10255.948720256425;10261.486925653762;10315.277930544866;10321.948390258076;3981.422693709396;4063.309237429644;4110.815013324408;4122.896927576835;4133.483314585676;8897.688580899767;8903.866442003375;8936;8959.148880856308;8974.19232269099;3679.300932822755;4304.289792184317;4307.935380969288;4309.935350969738;4310.159518893785;3825.9426108608395;3926.9214615708097;3957.3866050762176;3967.8214480347874;3993.1813978134414;3423.4522476403654;3497.090756403353;3514.5431093957623;3548.538689970287;3575.9642403576154;1088.711491454765;1108.933463992147;1117.8826223246604;1125.6454216921643;1129.7683974785314;1129.5594718059963;1143.0969534068158;1151.326474012712;1164.173436859839;1199.598134624893;7010.298970102949;7045.330693584101;7062.540934839219;7120.71517139319;7122.28777122294;1044.4516628769957;1061.8778840433295;1071.4696225368336;1073.758404359013;1074.7635520185547;5248.947510524922;5269.1569348903995;5269.4730526947;5292.761825717852;5302.151655735141;7986.84026319482;8444.704435344856;8457.069722330538;8485.830283394422;8490.320774338039;8416.242538171595;8420.621072051772;8437.451565648336;8680.8697869532;8682.826343473094;6848.794536163923;6933.965330173317;6992.5105242633545;7006.404455621329;7071.71713131469;6879.862402752017;6892.931070689429;6895.275996020547;6904.516683832084;6911.3779759821855;7890.644920978455;8207.835843283221;8222.794430139294;8327.916720832714;8365.790855228668;8065.233802788725;8202.17978202175;8280.751577452686;8299.211574900375;8314.958425207835;6086.239220097488;6141.385861413823;6199.442050215503;6225.719842607185;6225.750969961151;7116.928830711627;7139.143302803489;7167.426605871414;7179.820504487429;7199.3520583147765;6199.535034872312;6386.68066596659;6421.325760795236;6422.518311126778;6493.967530162319;6317.084022816574;6350.364963503613;6405.135306733531;6441.098246245623;6458.838529036811;6892.276310987274;6953.269906659728;6963.1296087989;6996.580205187705;7006.824829379102;6197.132401463708;6257.530685198537;6258.3741625838875;6277.372262773686;6338.176037115146;6246.625202487865;6307.085472606538;6311.116443697794;6316.526260530387;6328.493720502257 05:48:36 INFO - PROCESS | 26559 | |4;prototype.html;302.1102852100564;304.2697525937749;305.04368803800105;307.31315509835525;308.2924687841404;5132.358455193096;5181.533661970422;5268.315119034525;5309.389420216677;5364.436734142917;5158.045761534119;5210.661307015051;5228.006678731048;5229.477052294778;5246.396664383587;3798.6771124454453;3880.941785873214;4003.0392705750555;4018.2164477926817;4021.7385869918508;4013.458183145282;4014.437978682987;4017.1965606878593;4031.5766844481345;4037.7375470594466;3979.602039796026;3983.243183795084;3983.7012224083164;3995.900102497432;4002.8198731057173;3742.045778326523;3889.533256009269;3982.1040265940223;3986.760794352348;3996.2606917720314;3466.185446420089;3469.410200265961;3471.548698669182;3471.9132021699406;3483.372992861284;4965.82619608312;4985.376827896513;4985.925211121836;4987.7755501002175;4989.775460104304;4565.497795242521;4573.885652858705;4577.679562430631;4577.9542204577865;4584.4957054723955;5426.67439953604;5439.401665816757;5448.37343705475;5452.154915988028;5453.372862120827;3784.243151369737;3784.299904517673;3786.829592668309;3788.3181027415053;3788.393856982897;5496.0931446311315;5631.831045068655;5671.7447714852515;5684.317881854163;5728.570357223225;3799.677027452642;3800.771953682788;3809.3904975203836;3818.3317919364554;3826.0052386379743;3853.537575490959;3857.1514266861805;3859.26673931952;3859.710521710883;3864.9806750966063;4461.665375096881;4465.866024019285;4466.129104824593;4469.329600559877;4474.082813023322;5452.754626041838;5470.343558772973;5478.890422191614;5481.780728770885;5486.835394938078;1355.1868878672915;1355.241065003601;1356.6269275948996;1356.8737947503548;1358.0697222402687;838.6310023589601;881.7178502879145;922.8846394200725;933.5472295936465;939.1031564855547;4709.905801883943;4795.400574928134;4804.42346918372;4819.036192761461;4870.829520966749;5657.915131272952;5691.943080569225;5695.829125126253;5698.515626171739;5700.914486282709;4842.273658951185;4842.5157484251295;4844.4186697596515;4849.4908034656555;4855.393075865517;2990.0431861804013;3042.239440139965;3042.3458956324052;3047.695230476979;3051.4659934511374;5367.194920761839;5368.812091576776;5372.597055220874;5377.327834020747;5383.461653834664;5628.296462942132;5833.4749872511675;5839.708014599253;5847.181394604674;5864.970675146682;5355.812546560852;5363.249145119765;5363.302770639792;5364.195370694427;5375.623706340519;5675.829725108253;5676.517496012885;5681.77272909079;5682.573806964411;5691.715414229355;5592.580556458363;5595.63628364155;5599.076152434803;5603.215549822947;5607.579431542569;5342.519173274424;5348.331458567679;5357.1696387060065;5361.785528578813;5370.543503802221;3732.9066773330883;3845.3270677631863;3865.2076324354002;3873.806309684561;3876.5348158221195;5651.095824668033;5672.829815105553;5680.772769089355;5681.517071048842;5689.31728192603;5472.644278121909;5478.315210598676;5478.479544443271;5480.314960629921;5482.479164479368;5421.186821976735;5464.043792336246;5471.534919531884;5471.671699698031;5475.972620136874;5359.705216213146;5362.597805164551;5364.597655175799;5366;5367.302250707539;5306.442823503477;5478;5500.559955203494;5517.36550296721;5529.695866727368;5294.576433885357;5312.574994000548;5319.414864364994;5319.973400132974;5320.122179840283 05:48:36 INFO - PROCESS | 26559 | |5;yui.html;680.357062575866;715.1311156944312;728.8432986907815;743.2196193996306;748.5209465941795;11468.254563453369;11623.128265380088;11679.941600291997;11694.181407301492;11703.414829258545;11728.237664551798;11738.119641026915;11763.470643821027;11799.05607551396;11819.881801181986;631.7694041674779;800.0079900922857;808.6724876425058;817.2562967699365;835.1815221083342;819.6229734322219;821.720614990903;823.0493779684444;823.2672921100226;823.501781422237;866.4368160695535;869.74342568942;869.7869022089596;870.0081906626451;871.1375738019378;657.2572992518471;846.6951897316992;860.9053004169599;861.0313397427893;862.021605477781;635.5646382228189;635.5741653092439;635.6472157952335;635.6662752055162;635.9745610175587;11872.762544749057;11883.049356051495;11941.164118511708;11964.58123965657;11966.64100076999;12039.458224379923;12490.75018499625;12671;12721.30032848193;12734.61796146117;9737.853932191023;9902.405855648683;10051.396916185053;10194.490275486196;10292.382457052527;3278.5901762279714;3345.063382252973;3365.040963325465;3377.324535092991;3381.644927282649;36630.267394652226;37068.25863482742;37292.813535932146;37328.25343493142;37433.812830935945;8883.37816352849;9101.726948191565;9246;9398.577064031999;9448.858267126;15557;15581.610459738371;15611.3755449783;15679.902406831641;15743;6647.368499992493;6765.797026089225;6778.72885084601;6815.591064536144;6855.383015528626;3787.8484860605267;3788.677962373174;3818.102745854722;3860.5560360558334;3886.378179491268;2836.9007084751934;2883.668378136499;2889.0754958413104;2894.0594306850357;2902.3034471727055;493.66496471688396;509.5057793939872;516.7803683434526;517.2396577031757;520.0119772432333;464.21315869600704;489.3980404102973;506.9152014688496;510.82887232776693;634.8698516804044;7812.804679883048;7842.764717058498;7908.644111015018;8198.1391953844;8211.302039326605;593.1962191230906;600.0818747316613;628.5129025005657;634.8222497700651;636.1507387637556;3478.89563313101;3734.2158146788934;3790.8104594770152;3882.184741204322;3885.86399476017;49097.50902491001;51366.48633513692;51878.48121518812;51994.22008669798;52126.73936630293;44594.55405445969;44684.776576116914;44691.329630055574;44924.55075449269;45333;40352;40929;41394.586054139676;41567.792161039004;42474.15051699011;8632;8665;8710.91289087101;8797.736067917973;8926.375153739176;30895;30982.84508577443;31500.369992600477;32329.676703233607;32391.676083238865;35444.645553544135;35967.28065438729;38338.42492362561;40459.19081618292;40491;10113.797724045626;10242.539085741011;10382.532786024798;10445;10447.634332798316;9053.77365565866;11083.334999900031;11439.714007149887;11705.648830535098;11755;10726.356418614909;10767.515461804394;11029.944850275697;11315.528981232386;11389.829152562885;11321.71695707614;11508.194426390073;11550.425139924235;11650.6504804856;11954;9950.35322704022;10294.845577316497;10463.895361046596;10494.160467162455;10696.83954740664;8200.83598328042;8278.917210827814;8484.363672724447;8596.570171491276;8812.955935220283;8637.654493820177;8689.652413903626;8735.737927862174;8774.561271936505;8882.911170888208 05:48:36 INFO - PROCESS | 26559 | __end_tp_report 05:48:36 INFO - PROCESS | 26559 | __start_cc_report 05:48:36 INFO - PROCESS | 26559 | _x_x_mozilla_cycle_collect,770 05:48:36 INFO - PROCESS | 26559 | __end_cc_report 05:48:36 INFO - PROCESS | 26559 | __startTimestamp1457617716493__endTimestamp 05:48:36 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | ------- Summary: start ------- 05:48:36 INFO - PROCESS | 26559 | Number of tests: 6 05:48:36 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | [#0] dojo.html Cycles:165 Average:4452.71 Median:4563.25 stddev:441.40 (9.7%) stddev-sans-first:417.11 05:48:36 INFO - PROCESS | 26559 | Values: 2562.8 2638.1 2643.1 2651.2 2675.5 4435.6 4488.7 4492.2 4520.4 4521.5 4491.1 4542.4 4542.4 4549.5 4630.5 4155.3 4179.8 4184.1 4197.2 4297.7 4069.4 4240.6 4274.1 4281.0 4291.9 4158.1 4180.9 4188.6 4212.1 4242.4 4170.1 4171.9 4174.6 4197.3 4221.5 4111.2 4143.3 4169.9 4181.4 4213.2 4444.9 4474.8 4506.6 4524.0 4526.5 4772.5 4792.5 4793.6 4799.5 4832.3 4693.4 4809.1 4818.1 4825.0 4868.8 4520.1 4541.5 4558.0 4591.4 4595.4 4874.0 4880.6 4882.0 4883.2 4920.1 4654.7 4687.8 4691.5 4740.8 4748.4 4852.7 4871.5 4872.6 4891.5 4915.8 4768.6 4800.6 4806.0 4820.1 4858.5 4657.9 4780.7 4797.4 4840.7 4866.2 4011.0 4025.7 4035.6 4057.2 4058.2 3569.4 3570.2 3574.4 3591.7 3616.8 4077.2 4109.9 4149.9 4158.3 4203.4 4801.9 4804.8 4808.8 4827.7 4843.9 4153.1 4155.1 4169.5 4179.8 4200.8 4234.9 4247.2 4297.9 4308.9 4314.5 4467.9 4470.1 4477.0 4498.3 4514.3 4715.8 4716.8 4726.7 4727.2 4753.8 4471.0 4483.9 4559.6 4625.1 4635.4 4715.7 4720.3 4729.5 4734.3 4746.7 4764.8 4784.8 4785.2 4802.0 4827.6 4577.0 4626.0 4677.5 4700.4 4718.5 4645.7 4650.8 4666.7 4668.0 4694.5 4449.6 4583.1 4586.8 4592.3 4625.0 4719.4 4765.9 4767.1 4801.0 4803.2 4529.3 4563.2 4564.6 4566.7 4600.4 05:48:36 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | [#1] ext.html Cycles:180 Average:39378.49 Median:33949.25 stddev:64261.28 (189.3%) stddev-sans-first:64375.17 05:48:36 INFO - PROCESS | 26559 | Values: 479.5 488.1 488.7 494.3 511.6 24536.5 33089.5 33283.7 33381.3 33431.0 36578.3 36864.6 37031.7 37096.0 37136.6 6900.9 7609.4 7811.6 7815.1 9547.9 9732.2 9877.3 9886.1 9892.8 9893.4 9870.2 9968.5 9968.6 9969.8 9973.2 9780.8 9884.4 9892.8 9898.0 9898.8 9615.4 10082.7 10092.1 10105.6 10106.6 38315.4 38750.2 38751.8 38774.8 38782.0 2911.9 3067.9 3504.2 3544.3 3561.2 28105.7 28598.9 28632.1 28694.4 29041.4 3453.3 3479.7 3601.5 3623.2 3634.8 224133.0 224871.0 226309.0 226394.0 227844.0 38669.5 39137.2 39183.6 53967.5 54381.7 36682.0 36739.4 36866.3 36881.9 36897.4 12172.3 13322.2 13475.8 13482.3 13493.9 10242.5 10519.8 10576.8 10581.9 10596.4 13012.0 13168.8 13179.6 13201.2 13333.2 5492.6 5536.5 5555.9 5559.8 5612.8 802.8 806.0 863.8 953.2 976.3 26324.6 28572.7 29354.7 30105.4 30114.4 913.4 926.2 934.1 960.9 1093.8 13698.9 14100.4 14381.4 14391.8 14395.5 303495.0 305669.0 308368.0 310782.0 312198.0 47382.8 47852.8 47871.3 47883.0 48032.5 1149.3 1195.0 1220.6 1238.2 1247.1 23936.0 24801.5 26280.3 27073.1 27077.2 35971.0 36267.1 36342.0 36751.0 36767.6 188485.0 189929.0 190032.0 190203.0 190221.0 23977.3 28091.7 28337.3 28373.9 28654.7 33294.0 40711.4 41721.6 41861.2 42264.6 30759.4 32452.8 32534.5 33909.5 34214.3 33515.5 33926.0 33972.5 34082.8 34251.7 33243.7 33561.2 34041.5 34097.7 34126.7 29613.4 30582.2 30799.2 30799.7 30878.8 23692.4 23906.5 24098.9 24205.8 24314.4 05:48:36 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | [#2] jquery.html Cycles:180 Average:21999.08 Median:4992.02 stddev:60476.58 (1211.5%) stddev-sans-first:60624.32 05:48:36 INFO - PROCESS | 26559 | Values: 314.3 322.4 332.3 336.9 338.1 14549.8 15110.4 15566.9 15572.4 15623.1 15872.2 15917.8 16152.0 16159.8 16288.9 4830.8 5034.1 5064.2 5081.8 5088.4 4746.4 4934.6 4935.3 4938.0 4950.0 4813.9 4877.6 4902.7 4903.6 4917.2 5116.3 5129.0 5151.7 5165.9 5168.1 4924.2 4939.9 4945.6 4947.3 4948.0 11564.2 11587.9 11596.2 11599.4 12293.7 1659.7 1664.0 1724.9 1760.4 1843.3 8426.4 8577.8 8751.9 8812.8 9127.8 1734.8 1746.7 1757.6 1777.7 1784.4 55163.0 56645.0 56939.0 58042.0 59110.0 8869.1 9059.5 9874.9 9887.0 10034.0 12677.4 12839.4 12849.4 12874.4 12878.5 7058.0 7139.2 7170.1 7299.2 7300.8 6893.4 6909.0 6928.7 7034.8 7064.5 4138.4 4193.5 4229.4 4242.2 4301.7 1557.5 1598.4 1608.6 1619.6 1641.9 845.3 859.8 863.6 864.4 875.7 14665.7 15210.8 15229.8 15243.3 15553.6 777.2 779.4 806.4 818.9 929.4 8574.8 8812.6 8846.6 8880.6 9030.1 347468.0 369604.0 373632.0 374072.0 374502.0 65054.7 68379.7 68431.7 68503.3 69444.3 858.5 875.4 939.9 943.5 946.0 13557.7 13825.7 13888.7 13932.9 14102.7 30314.0 30824.7 31487.3 32053.8 32107.7 40471.8 41583.2 41596.8 42980.4 44015.0 6804.1 7104.5 7136.1 7318.5 7336.4 8080.8 10513.5 10965.8 11296.9 11342.9 9320.9 9528.0 9626.0 9636.6 9954.6 9377.3 9499.0 9636.9 9716.3 9820.8 9555.7 9720.7 9858.6 9936.7 9950.0 6556.5 6572.6 6815.8 6877.1 7155.9 8597.7 8641.7 8664.4 8812.2 8863.2 05:48:36 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | [#3] mootools.html Cycles:180 Average:5165.92 Median:6225.74 stddev:2673.96 (43.0%) stddev-sans-first:2665.13 05:48:36 INFO - PROCESS | 26559 | Values: 1234.1 1437.5 1449.4 1612.7 1807.0 6409.2 7265.4 7442.3 7447.9 7451.6 7200.3 7345.6 7361.3 7371.3 7384.1 1822.8 2082.2 2135.1 2161.9 2197.3 2184.9 2231.2 2232.4 2235.1 2235.6 2119.5 2183.8 2187.3 2188.8 2189.5 2130.7 2152.0 2154.8 2164.5 2168.9 2151.4 2175.2 2183.1 2186.8 2187.7 7352.7 7398.0 7419.8 7429.0 7434.0 4328.1 4451.2 4456.9 4465.3 4472.5 2836.4 2836.7 2897.4 2902.2 3001.6 934.5 936.5 941.8 948.3 968.3 10137.2 10255.9 10261.5 10315.3 10321.9 3981.4 4063.3 4110.8 4122.9 4133.5 8897.7 8903.9 8936.0 8959.1 8974.2 3679.3 4304.3 4307.9 4309.9 4310.2 3825.9 3926.9 3957.4 3967.8 3993.2 3423.5 3497.1 3514.5 3548.5 3576.0 1088.7 1108.9 1117.9 1125.6 1129.8 1129.6 1143.1 1151.3 1164.2 1199.6 7010.3 7045.3 7062.5 7120.7 7122.3 1044.5 1061.9 1071.5 1073.8 1074.8 5248.9 5269.2 5269.5 5292.8 5302.2 7986.8 8444.7 8457.1 8485.8 8490.3 8416.2 8420.6 8437.5 8680.9 8682.8 6848.8 6934.0 6992.5 7006.4 7071.7 6879.9 6892.9 6895.3 6904.5 6911.4 7890.6 8207.8 8222.8 8327.9 8365.8 8065.2 8202.2 8280.8 8299.2 8315.0 6086.2 6141.4 6199.4 6225.7 6225.8 7116.9 7139.1 7167.4 7179.8 7199.4 6199.5 6386.7 6421.3 6422.5 6494.0 6317.1 6350.4 6405.1 6441.1 6458.8 6892.3 6953.3 6963.1 6996.6 7006.8 6197.1 6257.5 6258.4 6277.4 6338.2 6246.6 6307.1 6311.1 6316.5 6328.5 05:48:36 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | [#4] prototype.html Cycles:180 Average:4515.78 Median:5237.94 stddev:1346.05 (25.7%) stddev-sans-first:1312.15 05:48:36 INFO - PROCESS | 26559 | Values: 302.1 304.3 305.0 307.3 308.3 5132.4 5181.5 5268.3 5309.4 5364.4 5158.0 5210.7 5228.0 5229.5 5246.4 3798.7 3880.9 4003.0 4018.2 4021.7 4013.5 4014.4 4017.2 4031.6 4037.7 3979.6 3983.2 3983.7 3995.9 4002.8 3742.0 3889.5 3982.1 3986.8 3996.3 3466.2 3469.4 3471.5 3471.9 3483.4 4965.8 4985.4 4985.9 4987.8 4989.8 4565.5 4573.9 4577.7 4578.0 4584.5 5426.7 5439.4 5448.4 5452.2 5453.4 3784.2 3784.3 3786.8 3788.3 3788.4 5496.1 5631.8 5671.7 5684.3 5728.6 3799.7 3800.8 3809.4 3818.3 3826.0 3853.5 3857.2 3859.3 3859.7 3865.0 4461.7 4465.9 4466.1 4469.3 4474.1 5452.8 5470.3 5478.9 5481.8 5486.8 1355.2 1355.2 1356.6 1356.9 1358.1 838.6 881.7 922.9 933.5 939.1 4709.9 4795.4 4804.4 4819.0 4870.8 5657.9 5691.9 5695.8 5698.5 5700.9 4842.3 4842.5 4844.4 4849.5 4855.4 2990.0 3042.2 3042.3 3047.7 3051.5 5367.2 5368.8 5372.6 5377.3 5383.5 5628.3 5833.5 5839.7 5847.2 5865.0 5355.8 5363.2 5363.3 5364.2 5375.6 5675.8 5676.5 5681.8 5682.6 5691.7 5592.6 5595.6 5599.1 5603.2 5607.6 5342.5 5348.3 5357.2 5361.8 5370.5 3732.9 3845.3 3865.2 3873.8 3876.5 5651.1 5672.8 5680.8 5681.5 5689.3 5472.6 5478.3 5478.5 5480.3 5482.5 5421.2 5464.0 5471.5 5471.7 5476.0 5359.7 5362.6 5364.6 5366.0 5367.3 5306.4 5478.0 5500.6 5517.4 5529.7 5294.6 5312.6 5319.4 5320.0 5320.1 05:48:36 INFO - PROCESS | 26559 | 05:48:36 INFO - PROCESS | 26559 | [#5] yui.html Cycles:180 Average:12287.21 Median:43534.35 stddev:13723.09 (31.5%) stddev-sans-first:13733.90 05:48:36 INFO - PROCESS | 26559 | Values: 680.4 715.1 728.8 743.2 748.5 11468.3 11623.1 11679.9 11694.2 11703.4 11728.2 11738.1 11763.5 11799.1 11819.9 631.8 800.0 808.7 817.3 835.2 819.6 821.7 823.0 823.3 823.5 866.4 869.7 869.8 870.0 871.1 657.3 846.7 860.9 861.0 862.0 635.6 635.6 635.6 635.7 636.0 11872.8 11883.0 11941.2 11964.6 11966.6 12039.5 12490.8 12671.0 12721.3 12734.6 9737.9 9902.4 10051.4 10194.5 10292.4 3278.6 3345.1 3365.0 3377.3 3381.6 36630.3 37068.3 37292.8 37328.3 37433.8 8883.4 9101.7 9246.0 9398.6 9448.9 15557.0 15581.6 15611.4 15679.9 15743.0 6647.4 6765.8 6778.7 6815.6 6855.4 3787.8 3788.7 3818.1 3860.6 3886.4 2836.9 2883.7 2889.1 2894.1 2902.3 493.7 509.5 516.8 517.2 520.0 464.2 489.4 506.9 510.8 634.9 7812.8 7842.8 7908.6 8198.1 8211.3 593.2 600.1 628.5 634.8 636.2 3478.9 3734.2 3790.8 3882.2 3885.9 49097.5 51366.5 51878.5 51994.2 52126.7 44594.6 44684.8 44691.3 44924.6 45333.0 40352.0 40929.0 41394.6 41567.8 42474.2 8632.0 8665.0 8710.9 8797.7 8926.4 30895.0 30982.8 31500.4 32329.7 32391.7 35444.6 35967.3 38338.4 40459.2 40491.0 10113.8 10242.5 10382.5 10445.0 10447.6 9053.8 11083.3 11439.7 11705.6 11755.0 10726.4 10767.5 11029.9 11315.5 11389.8 11321.7 11508.2 11550.4 11650.7 11954.0 9950.4 10294.8 10463.9 10494.2 10696.8 8200.8 8278.9 8484.4 8596.6 8813.0 8637.7 8689.7 8735.7 8774.6 8882.9 05:48:36 INFO - PROCESS | 26559 | -------- Summary: end -------- 05:48:36 INFO - PROCESS | 26559 | 05:48:37 INFO - TEST-INFO | 26559: exit 0 05:48:37 INFO - TEST-OK | dromaeo_css | took 1117278ms 05:48:37 INFO - TEST-START | kraken 05:48:37 INFO - operating with platform_type : linux_ 05:48:37 INFO - Initialising browser for kraken test... 05:48:37 INFO - TEST-INFO | started process 26740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_vTJEk/profile http://localhost:41755/getInfo.html) 05:48:41 INFO - PROCESS | 26740 | __metrics Screen width/height:1600/1200 05:48:41 INFO - PROCESS | 26740 | colorDepth:24 05:48:41 INFO - PROCESS | 26740 | Browser inner width/height: 1024/697 05:48:41 INFO - PROCESS | 26740 | __metrics 05:48:42 ERROR - PROCESS | 26740 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:48:42 INFO - PROCESS | 26740 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:48:43 INFO - TEST-INFO | 26740: exit 0 05:48:43 INFO - Browser initialized. 05:48:43 INFO - Running cycle 1/1 for kraken test... 05:48:43 INFO - TEST-INFO | started process 26822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_vTJEk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:55 INFO - PROCESS | 26822 | RSS: Main: 154202112 05:48:55 INFO - PROCESS | 26822 | 05:48:58 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41755/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:58 INFO - PROCESS | 26822 | RSS: Main: 195727360 05:48:58 INFO - PROCESS | 26822 | 05:49:01 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41755/tests/kraken/driver.html?testName=audio-dft) 05:49:02 INFO - PROCESS | 26822 | RSS: Main: 184668160 05:49:02 INFO - PROCESS | 26822 | 05:49:05 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41755/tests/kraken/driver.html?testName=audio-fft) 05:49:05 INFO - PROCESS | 26822 | RSS: Main: 173449216 05:49:05 INFO - PROCESS | 26822 | 05:49:07 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41755/tests/kraken/driver.html?testName=audio-oscillator) 05:49:08 INFO - PROCESS | 26822 | RSS: Main: 173125632 05:49:08 INFO - PROCESS | 26822 | 05:49:10 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:11 INFO - PROCESS | 26822 | RSS: Main: 174387200 05:49:11 INFO - PROCESS | 26822 | 05:49:14 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41755/tests/kraken/driver.html?testName=imaging-darkroom) 05:49:15 INFO - PROCESS | 26822 | RSS: Main: 176103424 05:49:15 INFO - PROCESS | 26822 | 05:49:18 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41755/tests/kraken/driver.html?testName=imaging-desaturate) 05:49:19 INFO - PROCESS | 26822 | RSS: Main: 173965312 05:49:19 INFO - PROCESS | 26822 | 05:49:22 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41755/tests/kraken/driver.html?testName=json-parse-financial) 05:49:23 INFO - PROCESS | 26822 | RSS: Main: 175349760 05:49:23 INFO - PROCESS | 26822 | 05:49:24 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:49:25 INFO - PROCESS | 26822 | RSS: Main: 185810944 05:49:25 INFO - PROCESS | 26822 | 05:49:27 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41755/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:49:27 INFO - PROCESS | 26822 | RSS: Main: 181698560 05:49:27 INFO - PROCESS | 26822 | 05:49:30 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:49:30 INFO - PROCESS | 26822 | RSS: Main: 193560576 05:49:30 INFO - PROCESS | 26822 | 05:49:33 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:33 INFO - PROCESS | 26822 | RSS: Main: 198701056 05:49:33 INFO - PROCESS | 26822 | 05:49:36 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:49:37 INFO - PROCESS | 26822 | RSS: Main: 198844416 05:49:37 INFO - PROCESS | 26822 | 05:49:38 INFO - PROCESS | 26822 | Cycle 1(1): loaded http://localhost:41755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41755/tests/kraken/driver.html?testName=ai-astar) 05:49:39 INFO - PROCESS | 26822 | RSS: Main: 259067904 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | __start_tp_report 05:49:39 INFO - PROCESS | 26822 | _x_x_mozilla_page_load 05:49:39 INFO - PROCESS | 26822 | _x_x_mozilla_page_load_details 05:49:39 INFO - PROCESS | 26822 | |i|pagename|runs| 05:49:39 INFO - PROCESS | 26822 | |0;ai-astar;112;114;110;115;115;114;105;114;113;115 05:49:39 INFO - PROCESS | 26822 | |1;audio-beat-detection;166;133;156;180;140;158;152;133;185;140 05:49:39 INFO - PROCESS | 26822 | |2;audio-dft;163;160;161;160;163;162;161;162;162;162 05:49:39 INFO - PROCESS | 26822 | |3;audio-fft;74;74;97;98;74;73;73;111;93;73 05:49:39 INFO - PROCESS | 26822 | |4;audio-oscillator;94;95;143;94;94;95;145;94;95;142 05:49:39 INFO - PROCESS | 26822 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 05:49:39 INFO - PROCESS | 26822 | |6;imaging-darkroom;178;172;174;174;177;172;170;174;174;178 05:49:39 INFO - PROCESS | 26822 | |7;imaging-desaturate;96;96;96;95;95;95;96;96;95;95 05:49:39 INFO - PROCESS | 26822 | |8;json-parse-financial;67;67;69;66;66;66;66;67;65;66 05:49:39 INFO - PROCESS | 26822 | |9;json-stringify-tinderbox;70;71;71;70;70;71;71;71;71;71 05:49:39 INFO - PROCESS | 26822 | |10;stanford-crypto-aes;82;85;83;87;84;85;84;84;97;83 05:49:39 INFO - PROCESS | 26822 | |11;stanford-crypto-ccm;130;129;124;118;117;129;127;128;118;118 05:49:39 INFO - PROCESS | 26822 | |12;stanford-crypto-pbkdf2;153;137;152;140;147;148;147;159;150;148 05:49:39 INFO - PROCESS | 26822 | |13;stanford-crypto-sha256-iterative;74;72;71;74;71;70;75;71;71;70 05:49:39 INFO - PROCESS | 26822 | __end_tp_report 05:49:39 INFO - PROCESS | 26822 | __start_cc_report 05:49:39 INFO - PROCESS | 26822 | _x_x_mozilla_cycle_collect,1139 05:49:39 INFO - PROCESS | 26822 | __end_cc_report 05:49:39 INFO - PROCESS | 26822 | __startTimestamp1457617779095__endTimestamp 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | ------- Summary: start ------- 05:49:39 INFO - PROCESS | 26822 | Number of tests: 14 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.13 (2.7%) stddev-sans-first:3.31 05:49:39 INFO - PROCESS | 26822 | Values: 112.0 114.0 110.0 115.0 115.0 114.0 105.0 114.0 113.0 115.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:157.00 stddev:18.49 (11.8%) stddev-sans-first:19.12 05:49:39 INFO - PROCESS | 26822 | Values: 166.0 133.0 156.0 180.0 140.0 158.0 152.0 133.0 185.0 140.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.01 05:49:39 INFO - PROCESS | 26822 | Values: 163.0 160.0 161.0 160.0 163.0 162.0 161.0 162.0 162.0 162.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#3] audio-fft Cycles:10 Average:84.00 Median:74.00 stddev:14.29 (19.3%) stddev-sans-first:14.69 05:49:39 INFO - PROCESS | 26822 | Values: 74.0 74.0 97.0 98.0 74.0 73.0 73.0 111.0 93.0 73.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:94.00 stddev:23.64 (25.1%) stddev-sans-first:24.43 05:49:39 INFO - PROCESS | 26822 | Values: 94.0 95.0 143.0 94.0 94.0 95.0 145.0 94.0 95.0 142.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:49:39 INFO - PROCESS | 26822 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#6] imaging-darkroom Cycles:10 Average:174.30 Median:174.00 stddev:2.67 (1.5%) stddev-sans-first:2.47 05:49:39 INFO - PROCESS | 26822 | Values: 178.0 172.0 174.0 174.0 177.0 172.0 170.0 174.0 174.0 178.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:49:39 INFO - PROCESS | 26822 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 05:49:39 INFO - PROCESS | 26822 | Values: 67.0 67.0 69.0 66.0 66.0 66.0 66.0 67.0 65.0 66.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 05:49:39 INFO - PROCESS | 26822 | Values: 70.0 71.0 71.0 70.0 70.0 71.0 71.0 71.0 71.0 71.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.50 stddev:4.30 (5.1%) stddev-sans-first:4.38 05:49:39 INFO - PROCESS | 26822 | Values: 82.0 85.0 83.0 87.0 84.0 85.0 84.0 84.0 97.0 83.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:127.50 stddev:5.45 (4.3%) stddev-sans-first:5.30 05:49:39 INFO - PROCESS | 26822 | Values: 130.0 129.0 124.0 118.0 117.0 129.0 127.0 128.0 118.0 118.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:149.00 stddev:6.26 (4.2%) stddev-sans-first:6.39 05:49:39 INFO - PROCESS | 26822 | Values: 153.0 137.0 152.0 140.0 147.0 148.0 147.0 159.0 150.0 148.0 05:49:39 INFO - PROCESS | 26822 | 05:49:39 INFO - PROCESS | 26822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.50 stddev:1.79 (2.5%) stddev-sans-first:1.73 05:49:39 INFO - PROCESS | 26822 | Values: 74.0 72.0 71.0 74.0 71.0 70.0 75.0 71.0 71.0 70.0 05:49:39 INFO - PROCESS | 26822 | -------- Summary: end -------- 05:49:39 INFO - PROCESS | 26822 | 05:49:40 INFO - TEST-INFO | 26822: exit 0 05:49:40 INFO - TEST-OK | kraken | took 62732ms 05:49:40 INFO - SUITE-END | took 1180s 05:49:40 INFO - Completed test suite (00:19:40) 05:49:40 INFO - javascript benchmark 05:49:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2562.7693507584313, 2638.116231062594, 2643.101345542515, 2651.2443953473253, 2675.464907018596, 4435.578620031092, 4488.685791994558, 4492.213862574053, 4520.367148599191, 4521.457425108983, 4491.056878055604, 4542.386777784998, 4542.409486766724, 4549.4768101668315, 4630.490646028942, 4155.272827255233, 4179.770112643803, 4184.121334519755, 4197.244495990721, 4297.720648157875, 4069.4302797608357, 4240.5547417521175, 4274.102438487906, 4280.957190428103, 4291.892702682427, 4158.064435502018, 4180.916381672349, 4188.602082802129, 4212.094399704079, 4242.4272723182285, 4170.145120250371, 4171.895702607429, 4174.582541745801, 4197.307444271692, 4221.535631080578, 4111.198316328318, 4143.316352801784, 4169.874903752892, 4181.351890456984, 4213.1573685262765, 4444.911101777979, 4474.82100715971, 4506.571875671806, 4524.0, 4526.4794548627, 4772.451168115676, 4792.544708252745, 4793.616510679172, 4799.496052914464, 4832.299316599108, 4693.366395536593, 4809.1343558159515, 4818.084563932842, 4824.951750482485, 4868.829590964299, 4520.11857687751, 4541.477730061019, 4558.0, 4591.357209990638, 4595.356650068926, 4873.975630121827, 4880.633952453581, 4882.0, 4883.194272944996, 4920.138975679241, 4654.697444666086, 4687.789049492781, 4691.507391723888, 4740.762961851894, 4748.406449193851, 4852.660313778072, 4871.464138944784, 4872.610191184696, 4891.461939186686, 4915.754212289371, 4768.61851051915, 4800.567948884547, 4805.975970120127, 4820.060088282751, 4858.489858564871, 4657.930131048037, 4780.737059461763, 4797.352357431771, 4840.685355451885, 4866.172750632401, 4010.979945100256, 4025.677945764332, 4035.596440355941, 4057.2494088593703, 4058.228936502055, 3569.428891377419, 3570.178858862424, 3574.3566158091794, 3591.748577599595, 3616.782993020427, 4077.1845630873945, 4109.856155034559, 4149.854755083557, 4158.293090174678, 4203.369494575777, 4801.855944321676, 4804.783784729696, 4808.783604737795, 4827.734474603931, 4843.903121937541, 4153.127843152912, 4155.10665206982, 4169.457970463881, 4179.832806687759, 4200.789960501963, 4234.87295381139, 4247.235497610398, 4297.892552686208, 4308.9353659695125, 4314.482262128565, 4467.865964021084, 4470.1059788041875, 4477.0, 4498.280275155959, 4514.277715565494, 4715.834945776881, 4716.787744551435, 4726.6691331607835, 4727.196376615915, 4753.83361582343, 4471.0, 4483.887902802456, 4559.635229181591, 4625.05186436773, 4635.374224479652, 4715.693479923794, 4720.268358404453, 4729.479757226633, 4734.289856521549, 4746.667733258639, 4764.78558464863, 4784.784684689267, 4785.234362501983, 4802.039592081667, 4827.589654879374, 4577.038821847449, 4625.953740462553, 4677.508861569486, 4700.435947686163, 4718.528147185254, 4645.67480276391, 4650.767461626972, 4666.650001249987, 4667.97304592989, 4694.530546945278, 4449.621782148424, 4583.1062942727185, 4586.8165273388695, 4592.311153327028, 4624.9768751156025, 4719.3628860103445, 4765.928511072268, 4767.141914455431, 4800.975995120002, 4803.183458811941, 4529.300189677627, 4563.247064234364, 4564.589186973189, 4566.748828814314, 4600.401947746772], "unit": "score", "name": "dojo.html", "value": 4426.493700693577}, {"lowerIsBetter": false, "replicates": [479.50371365636573, 488.10676462074406, 488.7165444042453, 494.3400560252063, 511.57794819274096, 24536.509269814593, 33089.50365744516, 33283.66716332836, 33381.33237335255, 33431.0, 36578.26843463129, 36864.631353686455, 37031.6671499565, 37096.0, 37136.628633713655, 6900.896486552706, 7609.3532049775695, 7811.648475818573, 7815.101263354702, 9547.856782148274, 9732.172765314921, 9877.308588398815, 9886.110250077492, 9892.802143957117, 9893.356931799446, 9870.161036311922, 9968.501574921262, 9968.551415186297, 9969.750756231117, 9973.152282055999, 9780.804383912318, 9884.357516761387, 9892.802143957153, 9898.0, 9898.752531186707, 9615.375000625007, 10082.69751907444, 10092.091711745978, 10105.646302379455, 10106.646267380607, 38315.425268620995, 38750.224995499935, 38751.806240968894, 38774.80612596947, 38782.0, 2911.8689658965186, 3067.884792512029, 3504.229069604683, 3544.2557063016798, 3561.198730285691, 28105.718942810516, 28598.85700571484, 28632.14103576896, 28694.426111477864, 29041.41917161666, 3453.3438646657055, 3479.6868281854754, 3601.5318008658705, 3623.184783423735, 3634.800085995269, 224133.0, 224871.0, 226309.0, 226394.0, 227844.0, 38669.48648337849, 39137.21725565473, 39183.608163918, 53967.46032539703, 54381.72809135929, 36682.0, 36739.4489082664, 36866.26267474636, 36881.89354319375, 36897.44653830195, 12172.2696638202, 13322.20066795976, 13475.797863032063, 13482.325883705775, 13493.865061349457, 10242.53908574116, 10519.789604208027, 10576.841347379795, 10581.894181058246, 10596.364218146937, 13012.0, 13168.802467962989, 13179.60461186166, 13201.20792752438, 13333.20000799955, 5492.5605951524585, 5536.529395001389, 5555.8888822223325, 5559.77760889568, 5612.831615051555, 802.8233788566506, 805.9919400805917, 863.7926897544544, 953.2421724728857, 976.3312131190157, 26324.60513092305, 28572.71427285742, 29354.706452935625, 30105.397892042038, 30114.397712045637, 913.4154141349542, 926.2312280806914, 934.1079269297804, 960.865478832964, 1093.797647435227, 13698.931505342409, 14100.435982560788, 14381.352839122264, 14391.78412323816, 14395.496157634641, 303495.0, 305669.0, 308368.0, 310782.0, 312198.0, 47382.76308618435, 47852.7607361961, 47871.28193077107, 47883.0, 48032.5196748035, 1149.316156886651, 1194.978293559012, 1220.6033039262452, 1238.2446707508414, 1247.114548670436, 23936.0, 24801.50396992086, 26280.29178103417, 27073.052443164393, 27077.1876843695, 35971.0, 36267.09332266715, 36342.0, 36751.0, 36767.63232367642, 188485.0, 189929.0, 190032.0, 190203.0, 190221.0, 23977.28068157958, 28091.71908280891, 28337.29156771097, 28373.858130709214, 28654.71345286604, 33294.0, 40711.38932916068, 41721.58278417177, 41861.1627767449, 42264.577354227295, 30759.384812304077, 32452.837735812114, 32534.511982320757, 33909.49135763015, 34214.31571368608, 33515.4972675415, 33926.0, 33972.49041264432, 34082.82958585191, 34251.657483424846, 33243.66756332406, 33561.16097097592, 34041.48937765886, 34097.65902340945, 34126.65873341235, 29613.407731845673, 30582.235444114074, 30799.2300192497, 30799.692003079683, 30878.845605772727, 23692.407689807893, 23906.521869562162, 24098.87950560236, 24205.757942421056, 24314.392140196636], "unit": "score", "name": "ext.html", "value": 16542.48720590941}, {"lowerIsBetter": false, "replicates": [314.2834337710021, 322.3778108251076, 332.3154742357479, 336.9022983334833, 338.1023382918353, 14549.78175327371, 15110.395584176633, 15566.922165389156, 15572.377104915819, 15623.14072726001, 15872.206389680527, 15917.84082159178, 16152.0, 16159.83840161598, 16288.918555407236, 4830.782614782334, 5034.0686972910125, 5064.215046667772, 5081.79672813087, 5088.389393272812, 4746.406699162605, 4934.605231581465, 4935.333729946447, 4938.012397520492, 4949.975250123744, 4813.879653008667, 4877.609791216694, 4902.7058376497525, 4903.583195428393, 4917.188663870457, 5116.258142569307, 5128.974355128219, 5151.716655583941, 5165.896682066356, 5168.147255702805, 4924.236743304794, 4939.925901111486, 4945.554900058976, 4947.307376967227, 4947.9505204947845, 11564.248323859007, 11587.884121158764, 11596.246243994114, 11599.362035088066, 12293.69265768354, 1659.6514731906314, 1663.991680041592, 1724.922378492971, 1760.3662681434673, 1843.3271855772546, 8426.410151289412, 8577.785555361104, 8751.906011748531, 8812.779680508038, 9127.817443651156, 1734.80917099119, 1746.6594014167242, 1757.6045389787323, 1777.6622441736029, 1784.3843873863495, 55163.0, 56645.0, 56939.0, 58042.0, 59110.0, 8869.113088691209, 9059.547022648841, 9874.901250987541, 9887.0, 10034.046765557261, 12677.366131693378, 12839.358032098358, 12849.4217760201, 12874.356282185854, 12878.549250776177, 7058.0, 7139.214686384494, 7170.139583250043, 7299.19708832028, 7300.817479563053, 6893.448524118058, 6909.0, 6928.653567321614, 7034.824129396704, 7064.470164737665, 4138.379243113557, 4193.475815523059, 4229.365595160751, 4242.151569686075, 4301.677374196947, 1557.524954888747, 1598.3686443854613, 1608.5817687401359, 1619.5627180661156, 1641.9261133249033, 845.2561745663777, 859.7678626770737, 863.6459051788736, 864.4381152251087, 875.6847534887436, 14665.706685866437, 15210.771838422432, 15229.771553426708, 15243.314050867515, 15553.611159720871, 777.1839568453101, 779.38818027849, 806.3589446390134, 818.9467684600601, 929.3958926697566, 8574.78563035929, 8812.647494100293, 8846.646134154691, 8880.644774208959, 9030.142136497023, 347468.0, 369604.0, 373632.0, 374072.0, 374502.0, 65054.674726626065, 68379.65810170917, 68431.65784171048, 68503.3149668507, 69444.30555694379, 858.4548811504615, 875.4309698695771, 939.9295052870925, 943.4763706143019, 946.0303189230956, 13557.728845423233, 13825.654358641115, 13888.722225555635, 13932.860671393157, 14102.717945641234, 30314.0, 30824.69175308218, 31487.308788055827, 32053.839730801195, 32107.678923211402, 40471.79764101161, 41583.168336632494, 41596.792016039726, 42980.35529466998, 44015.0, 6804.149481314836, 7104.502684812013, 7136.0723105995885, 7318.487705860539, 7336.449766267658, 8080.757577272691, 10513.474326283807, 10965.780684386427, 11296.943515282699, 11342.943285283522, 9320.860187097063, 9527.952360238154, 9626.037396260317, 9636.614535418505, 9954.601815927283, 9377.296702747184, 9498.95250523743, 9636.855447168158, 9716.3198576099, 9820.754481138028, 9555.665551705657, 9720.708378748648, 9858.556364963737, 9936.652217172365, 9950.046583543102, 6556.475481961527, 6572.638504882086, 6815.795526134224, 6877.071595334766, 7155.892661609976, 8597.656093756179, 8641.697540586048, 8664.436811607226, 8812.206901378906, 8863.202311791969], "unit": "score", "name": "jquery.html", "value": 7482.712899537411}, {"lowerIsBetter": false, "replicates": [1234.1299383934327, 1437.5256165465394, 1449.384011794987, 1612.685526322367, 1807.0332372180885, 6409.230892292926, 7265.418766498674, 7442.255774422555, 7447.925520744791, 7451.590162541058, 7200.279972002797, 7345.559266444017, 7361.337479626833, 7371.262873712626, 7384.076990376203, 1822.8177182281797, 2082.187946700788, 2135.1032566322183, 2161.9027143778567, 2197.307848027874, 2184.868907865533, 2231.163313757341, 2232.441889527618, 2235.1282999630075, 2235.552889422122, 2119.4913220826966, 2183.836212284077, 2187.289131032413, 2188.803007729304, 2189.4964158243615, 2130.6803979403057, 2152.0315857863948, 2154.8168405685537, 2164.4588852786806, 2168.9240876569243, 2151.3653472225733, 2175.227794133076, 2183.094015983365, 2186.759456459788, 2187.671849222613, 7352.742654007137, 7398.0, 7419.777406677808, 7429.0, 7434.033575635132, 4328.069465065026, 4451.1765323415275, 4456.866294011184, 4465.263231566788, 4472.485664148632, 2836.390176112125, 2836.7305106014896, 2897.4350001749667, 2902.1873875314946, 3001.564773107909, 934.5327336331834, 936.5317341329335, 941.7975135345933, 948.2745699539857, 968.2979839616293, 10137.239707021929, 10255.948720256425, 10261.486925653762, 10315.277930544866, 10321.948390258076, 3981.422693709396, 4063.309237429644, 4110.815013324408, 4122.896927576835, 4133.483314585676, 8897.688580899767, 8903.866442003375, 8936.0, 8959.148880856308, 8974.19232269099, 3679.300932822755, 4304.289792184317, 4307.935380969288, 4309.935350969738, 4310.159518893785, 3825.9426108608395, 3926.9214615708097, 3957.3866050762176, 3967.8214480347874, 3993.1813978134414, 3423.4522476403654, 3497.090756403353, 3514.5431093957623, 3548.538689970287, 3575.9642403576154, 1088.711491454765, 1108.933463992147, 1117.8826223246604, 1125.6454216921643, 1129.7683974785314, 1129.5594718059963, 1143.0969534068158, 1151.326474012712, 1164.173436859839, 1199.598134624893, 7010.298970102949, 7045.330693584101, 7062.540934839219, 7120.71517139319, 7122.28777122294, 1044.4516628769957, 1061.8778840433295, 1071.4696225368336, 1073.758404359013, 1074.7635520185547, 5248.947510524922, 5269.1569348903995, 5269.4730526947, 5292.761825717852, 5302.151655735141, 7986.84026319482, 8444.704435344856, 8457.069722330538, 8485.830283394422, 8490.320774338039, 8416.242538171595, 8420.621072051772, 8437.451565648336, 8680.8697869532, 8682.826343473094, 6848.794536163923, 6933.965330173317, 6992.5105242633545, 7006.404455621329, 7071.71713131469, 6879.862402752017, 6892.931070689429, 6895.275996020547, 6904.516683832084, 6911.3779759821855, 7890.644920978455, 8207.835843283221, 8222.794430139294, 8327.916720832714, 8365.790855228668, 8065.233802788725, 8202.17978202175, 8280.751577452686, 8299.211574900375, 8314.958425207835, 6086.239220097488, 6141.385861413823, 6199.442050215503, 6225.719842607185, 6225.750969961151, 7116.928830711627, 7139.143302803489, 7167.426605871414, 7179.820504487429, 7199.3520583147765, 6199.535034872312, 6386.68066596659, 6421.325760795236, 6422.518311126778, 6493.967530162319, 6317.084022816574, 6350.364963503613, 6405.135306733531, 6441.098246245623, 6458.838529036811, 6892.276310987274, 6953.269906659728, 6963.1296087989, 6996.580205187705, 7006.824829379102, 6197.132401463708, 6257.530685198537, 6258.3741625838875, 6277.372262773686, 6338.176037115146, 6246.625202487865, 6307.085472606538, 6311.116443697794, 6316.526260530387, 6328.493720502257], "unit": "score", "name": "mootools.html", "value": 4253.65977470866}, {"lowerIsBetter": false, "replicates": [302.1102852100564, 304.2697525937749, 305.04368803800105, 307.31315509835525, 308.2924687841404, 5132.358455193096, 5181.533661970422, 5268.315119034525, 5309.389420216677, 5364.436734142917, 5158.045761534119, 5210.661307015051, 5228.006678731048, 5229.477052294778, 5246.396664383587, 3798.6771124454453, 3880.941785873214, 4003.0392705750555, 4018.2164477926817, 4021.7385869918508, 4013.458183145282, 4014.437978682987, 4017.1965606878593, 4031.5766844481345, 4037.7375470594466, 3979.602039796026, 3983.243183795084, 3983.7012224083164, 3995.900102497432, 4002.8198731057173, 3742.045778326523, 3889.533256009269, 3982.1040265940223, 3986.760794352348, 3996.2606917720314, 3466.185446420089, 3469.410200265961, 3471.548698669182, 3471.9132021699406, 3483.372992861284, 4965.82619608312, 4985.376827896513, 4985.925211121836, 4987.7755501002175, 4989.775460104304, 4565.497795242521, 4573.885652858705, 4577.679562430631, 4577.9542204577865, 4584.4957054723955, 5426.67439953604, 5439.401665816757, 5448.37343705475, 5452.154915988028, 5453.372862120827, 3784.243151369737, 3784.299904517673, 3786.829592668309, 3788.3181027415053, 3788.393856982897, 5496.0931446311315, 5631.831045068655, 5671.7447714852515, 5684.317881854163, 5728.570357223225, 3799.677027452642, 3800.771953682788, 3809.3904975203836, 3818.3317919364554, 3826.0052386379743, 3853.537575490959, 3857.1514266861805, 3859.26673931952, 3859.710521710883, 3864.9806750966063, 4461.665375096881, 4465.866024019285, 4466.129104824593, 4469.329600559877, 4474.082813023322, 5452.754626041838, 5470.343558772973, 5478.890422191614, 5481.780728770885, 5486.835394938078, 1355.1868878672915, 1355.241065003601, 1356.6269275948996, 1356.8737947503548, 1358.0697222402687, 838.6310023589601, 881.7178502879145, 922.8846394200725, 933.5472295936465, 939.1031564855547, 4709.905801883943, 4795.400574928134, 4804.42346918372, 4819.036192761461, 4870.829520966749, 5657.915131272952, 5691.943080569225, 5695.829125126253, 5698.515626171739, 5700.914486282709, 4842.273658951185, 4842.5157484251295, 4844.4186697596515, 4849.4908034656555, 4855.393075865517, 2990.0431861804013, 3042.239440139965, 3042.3458956324052, 3047.695230476979, 3051.4659934511374, 5367.194920761839, 5368.812091576776, 5372.597055220874, 5377.327834020747, 5383.461653834664, 5628.296462942132, 5833.4749872511675, 5839.708014599253, 5847.181394604674, 5864.970675146682, 5355.812546560852, 5363.249145119765, 5363.302770639792, 5364.195370694427, 5375.623706340519, 5675.829725108253, 5676.517496012885, 5681.77272909079, 5682.573806964411, 5691.715414229355, 5592.580556458363, 5595.63628364155, 5599.076152434803, 5603.215549822947, 5607.579431542569, 5342.519173274424, 5348.331458567679, 5357.1696387060065, 5361.785528578813, 5370.543503802221, 3732.9066773330883, 3845.3270677631863, 3865.2076324354002, 3873.806309684561, 3876.5348158221195, 5651.095824668033, 5672.829815105553, 5680.772769089355, 5681.517071048842, 5689.31728192603, 5472.644278121909, 5478.315210598676, 5478.479544443271, 5480.314960629921, 5482.479164479368, 5421.186821976735, 5464.043792336246, 5471.534919531884, 5471.671699698031, 5475.972620136874, 5359.705216213146, 5362.597805164551, 5364.597655175799, 5366.0, 5367.302250707539, 5306.442823503477, 5478.0, 5500.559955203494, 5517.36550296721, 5529.695866727368, 5294.576433885357, 5312.574994000548, 5319.414864364994, 5319.973400132974, 5320.122179840283], "unit": "score", "name": "prototype.html", "value": 4082.1667065565925}, {"lowerIsBetter": false, "replicates": [680.357062575866, 715.1311156944312, 728.8432986907815, 743.2196193996306, 748.5209465941795, 11468.254563453369, 11623.128265380088, 11679.941600291997, 11694.181407301492, 11703.414829258545, 11728.237664551798, 11738.119641026915, 11763.470643821027, 11799.05607551396, 11819.881801181986, 631.7694041674779, 800.0079900922857, 808.6724876425058, 817.2562967699365, 835.1815221083342, 819.6229734322219, 821.720614990903, 823.0493779684444, 823.2672921100226, 823.501781422237, 866.4368160695535, 869.74342568942, 869.7869022089596, 870.0081906626451, 871.1375738019378, 657.2572992518471, 846.6951897316992, 860.9053004169599, 861.0313397427893, 862.021605477781, 635.5646382228189, 635.5741653092439, 635.6472157952335, 635.6662752055162, 635.9745610175587, 11872.762544749057, 11883.049356051495, 11941.164118511708, 11964.58123965657, 11966.64100076999, 12039.458224379923, 12490.75018499625, 12671.0, 12721.30032848193, 12734.61796146117, 9737.853932191023, 9902.405855648683, 10051.396916185053, 10194.490275486196, 10292.382457052527, 3278.5901762279714, 3345.063382252973, 3365.040963325465, 3377.324535092991, 3381.644927282649, 36630.267394652226, 37068.25863482742, 37292.813535932146, 37328.25343493142, 37433.812830935945, 8883.37816352849, 9101.726948191565, 9246.0, 9398.577064031999, 9448.858267126, 15557.0, 15581.610459738371, 15611.3755449783, 15679.902406831641, 15743.0, 6647.368499992493, 6765.797026089225, 6778.72885084601, 6815.591064536144, 6855.383015528626, 3787.8484860605267, 3788.677962373174, 3818.102745854722, 3860.5560360558334, 3886.378179491268, 2836.9007084751934, 2883.668378136499, 2889.0754958413104, 2894.0594306850357, 2902.3034471727055, 493.66496471688396, 509.5057793939872, 516.7803683434526, 517.2396577031757, 520.0119772432333, 464.21315869600704, 489.3980404102973, 506.9152014688496, 510.82887232776693, 634.8698516804044, 7812.804679883048, 7842.764717058498, 7908.644111015018, 8198.1391953844, 8211.302039326605, 593.1962191230906, 600.0818747316613, 628.5129025005657, 634.8222497700651, 636.1507387637556, 3478.89563313101, 3734.2158146788934, 3790.8104594770152, 3882.184741204322, 3885.86399476017, 49097.50902491001, 51366.48633513692, 51878.48121518812, 51994.22008669798, 52126.73936630293, 44594.55405445969, 44684.776576116914, 44691.329630055574, 44924.55075449269, 45333.0, 40352.0, 40929.0, 41394.586054139676, 41567.792161039004, 42474.15051699011, 8632.0, 8665.0, 8710.91289087101, 8797.736067917973, 8926.375153739176, 30895.0, 30982.84508577443, 31500.369992600477, 32329.676703233607, 32391.676083238865, 35444.645553544135, 35967.28065438729, 38338.42492362561, 40459.19081618292, 40491.0, 10113.797724045626, 10242.539085741011, 10382.532786024798, 10445.0, 10447.634332798316, 9053.77365565866, 11083.334999900031, 11439.714007149887, 11705.648830535098, 11755.0, 10726.356418614909, 10767.515461804394, 11029.944850275697, 11315.528981232386, 11389.829152562885, 11321.71695707614, 11508.194426390073, 11550.425139924235, 11650.6504804856, 11954.0, 9950.35322704022, 10294.845577316497, 10463.895361046596, 10494.160467162455, 10696.83954740664, 8200.83598328042, 8278.917210827814, 8484.363672724447, 8596.570171491276, 8812.955935220283, 8637.654493820177, 8689.652413903626, 8735.737927862174, 8774.561271936505, 8882.911170888208], "unit": "score", "name": "yui.html", "value": 5809.692583174958}], "name": "dromaeo_css", "value": 6172.03391581819}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 110.0, 115.0, 115.0, 114.0, 105.0, 114.0, 113.0, 115.0], "unit": "score", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [166.0, 133.0, 156.0, 180.0, 140.0, 158.0, 152.0, 133.0, 185.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 154.3}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 161.0, 160.0, 163.0, 162.0, 161.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 97.0, 98.0, 74.0, 73.0, 73.0, 111.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 143.0, 94.0, 94.0, 95.0, 145.0, 94.0, 95.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [178.0, 172.0, 174.0, 174.0, 177.0, 172.0, 170.0, 174.0, 174.0, 178.0], "unit": "score", "name": "imaging-darkroom", "value": 174.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 66.5}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 70.0, 70.0, 71.0, 71.0, 71.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.7}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 83.0, 87.0, 84.0, 85.0, 84.0, 84.0, 97.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [130.0, 129.0, 124.0, 118.0, 117.0, 129.0, 127.0, 128.0, 118.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [153.0, 137.0, 152.0, 140.0, 147.0, 148.0, 147.0, 159.0, 150.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 71.0, 74.0, 71.0, 70.0, 75.0, 71.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1574.8000000000002}]} 05:49:40 INFO - Return code: 0 05:49:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:49:40 ERROR - # TBPL SUCCESS # 05:49:40 INFO - Running post-action listener: _resource_record_post_action 05:49:40 INFO - Running post-run listener: _resource_record_post_run 05:49:41 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521392128; Read time: 16; Write time: 521544 05:49:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233558016; Read time: 0; Write time: 297724 05:49:41 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287830016; Read time: 16; Write time: 223820 05:49:41 INFO - Running post-run listener: _upload_blobber_files 05:49:41 INFO - Blob upload gear active. 05:49:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:49:41 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:49:41 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:49:41 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:49:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:49:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:49:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:49:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:42 INFO - (blobuploader) - INFO - Done attempting. 05:49:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:49:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:43 INFO - (blobuploader) - INFO - Done attempting. 05:49:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:49:43 INFO - Return code: 0 05:49:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:49:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:49:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cf9b0cd8b496227f85327bf58f392ded2c38724bc9587e661e8fe41dca63779d82c56581380b48ccc77911cbeec5a8b8cfa26868ee19585b400545677b76aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8603f1370fb28c2f810f348b41968e7352bc82d15c668015b13c3489502272bf1d6be27eb69433228f8c624c542cfcd64034004989e514ae00a5f1603729bef0"} 05:49:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:49:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:49:43 INFO - Contents: 05:49:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cf9b0cd8b496227f85327bf58f392ded2c38724bc9587e661e8fe41dca63779d82c56581380b48ccc77911cbeec5a8b8cfa26868ee19585b400545677b76aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8603f1370fb28c2f810f348b41968e7352bc82d15c668015b13c3489502272bf1d6be27eb69433228f8c624c542cfcd64034004989e514ae00a5f1603729bef0"} 05:49:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:49:43 INFO - Copying logs to upload dir... 05:49:43 INFO - mkdir: /builds/slave/test/build/upload/logs 05:49:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.129886 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-03-10 05:49:43.571622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 05:49:43.578320) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 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/2cf9b0cd8b496227f85327bf58f392ded2c38724bc9587e661e8fe41dca63779d82c56581380b48ccc77911cbeec5a8b8cfa26868ee19585b400545677b76aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8603f1370fb28c2f810f348b41968e7352bc82d15c668015b13c3489502272bf1d6be27eb69433228f8c624c542cfcd64034004989e514ae00a5f1603729bef0"} build_url:https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/e7TTGCzGSEuAlD6O4zTccA/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/2cf9b0cd8b496227f85327bf58f392ded2c38724bc9587e661e8fe41dca63779d82c56581380b48ccc77911cbeec5a8b8cfa26868ee19585b400545677b76aea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8603f1370fb28c2f810f348b41968e7352bc82d15c668015b13c3489502272bf1d6be27eb69433228f8c624c542cfcd64034004989e514ae00a5f1603729bef0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 05:49:43.602687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:49:43.602993) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457616398.507360-1262475907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:49:43.689029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 05:49:43.689361) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 05:49:43.689724) ========= ========= Total master_lag: 0.33 =========