builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1457616537.98 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.975527) ========= 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.975880) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:57.976175) ========= 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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006669 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.021558) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.021837) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.043130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.043467) ========= 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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.101852) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.102278) ========= 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.102633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.102921) ========= 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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.2M=0s 2016-03-10 05:28:58 (50.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.298891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.299184) ========= 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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.148148 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.461236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.461590) ========= 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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-10 05:28:58,539 truncating revision to first 12 chars 2016-03-10 05:28:58,539 Setting DEBUG logging. 2016-03-10 05:28:58,539 attempt 1/10 2016-03-10 05:28:58,539 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:58,793 unpacking tar archive at: mozilla-central-dd1abe874252/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519400 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.993884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:58.994255) ========= 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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dd1abe874252e507b825a0a4e1063b0e13578288 program finished with exit code 0 elapsedTime=0.004623 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.044795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:59.045099) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 05:28:59.054693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-03-10 05:28:59.055057) ========= /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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 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-010', 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": 30, 05:29:00 INFO - "slavename": "talos-linux64-ix-010", 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:03 INFO - Downloaded 1361 bytes. 05:29:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:29:03 INFO - Using the following test package requirements: 05:29:03 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:29:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:29:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:03 INFO - u'jsshell-linux-x86_64.zip'], 05:29:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:29:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:29:03 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:29:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:29:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:29:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:29:03 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:03 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:03 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:03 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:03 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:03 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:05 INFO - Downloaded 22092856 bytes. 05:29:05 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:05 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:06 INFO - Return code: 0 05:29:06 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:06 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:06 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:06 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:06 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:06 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:06 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:24 INFO - Downloaded 22092856 bytes. 05:29:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:29:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:29:26 INFO - Return code: 0 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 - 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:26 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:26 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:26 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:26 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:27 INFO - Downloaded 10845161 bytes. 05:29:27 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:27 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:27 INFO - Return code: 0 05:29:27 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:27 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:27 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:27 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:27 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:27 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:29 INFO - Downloaded 54427597 bytes. 05:29:29 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:29 INFO - mkdir: /builds/slave/test/properties 05:29:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:29 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:29 INFO - Contents: 05:29:29 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:30 INFO - Running post-action listener: _resource_record_post_action 05:29:30 INFO - Running post-action listener: set_extra_try_arguments 05:29:30 INFO - ##### 05:29:30 INFO - ##### Running populate-webroot step. 05:29:30 INFO - ##### 05:29:30 INFO - Running pre-action listener: _resource_record_pre_action 05:29:30 INFO - Running main action method: populate_webroot 05:29:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:29:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:29:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:29:30 INFO - '--tppagecycles', 05:29:30 INFO - '7'], 05:29:30 INFO - 'tests': ['tsvgm']}}, 05:29:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:29:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:29:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:29:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:30 INFO - 'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:30 INFO - 'tests': ['damp', 'tps']}, 05:29:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:30 INFO - 'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['damp', 'tps']}, 05:29:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:29:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:30 INFO - 'other': {'tests': ['a11yr', 05:29:30 INFO - 'ts_paint', 05:29:30 INFO - 'tpaint', 05:29:30 INFO - 'sessionrestore', 05:29:30 INFO - 'sessionrestore_no_auto_restore', 05:29:30 INFO - 'tabpaint']}, 05:29:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['a11yr', 05:29:30 INFO - 'ts_paint', 05:29:30 INFO - 'tpaint', 05:29:30 INFO - 'sessionrestore', 05:29:30 INFO - 'sessionrestore_no_auto_restore', 05:29:30 INFO - 'tabpaint']}, 05:29:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['a11yr', 05:29:30 INFO - 'ts_paint', 05:29:30 INFO - 'tpaint', 05:29:30 INFO - 'sessionrestore', 05:29:30 INFO - 'sessionrestore_no_auto_restore', 05:29:30 INFO - 'tabpaint']}, 05:29:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['a11yr', 05:29:30 INFO - 'ts_paint', 05:29:30 INFO - 'tpaint', 05:29:30 INFO - 'sessionrestore', 05:29:30 INFO - 'sessionrestore_no_auto_restore', 05:29:30 INFO - 'tabpaint']}, 05:29:30 INFO - 'other_l64': {'tests': ['a11yr', 05:29:30 INFO - 'ts_paint', 05:29:30 INFO - 'tpaint', 05:29:30 INFO - 'sessionrestore', 05:29:30 INFO - 'sessionrestore_no_auto_restore', 05:29:30 INFO - 'tabpaint']}, 05:29:30 INFO - 'other_nol64': {'tests': ['a11yr', 05:29:30 INFO - 'ts_paint', 05:29:30 INFO - 'tpaint', 05:29:30 INFO - 'sessionrestore', 05:29:30 INFO - 'sessionrestore_no_auto_restore', 05:29:30 INFO - 'tabpaint']}, 05:29:30 INFO - 'svgr': {'tests': ['tsvgx', 05:29:30 INFO - 'tsvgr_opacity', 05:29:30 INFO - 'tart', 05:29:30 INFO - 'tscrollx', 05:29:30 INFO - 'cart']}, 05:29:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['tsvgx', 05:29:30 INFO - 'tsvgr_opacity', 05:29:30 INFO - 'tart', 05:29:30 INFO - 'tscrollx', 05:29:30 INFO - 'cart']}, 05:29:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:30 INFO - 'tests': ['tp5o']}, 05:29:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:30 INFO - 'talos_options': ['--e10s'], 05:29:30 INFO - 'tests': ['tp5o']}, 05:29:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:30 INFO - 'talos_options': ['--xperf_path', 05:29:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:30 INFO - 'tests': ['tp5n']}, 05:29:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:30 INFO - 'talos_options': ['--e10s', 05:29:30 INFO - '--xperf_path', 05:29:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:30 INFO - 'tests': ['tp5n']}}, 05:29:30 INFO - 'talos.zip': {'path': '', 05:29:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:29:30 INFO - Running post-action listener: _resource_record_post_action 05:29:30 INFO - ##### 05:29:30 INFO - ##### Running create-virtualenv step. 05:29:30 INFO - ##### 05:29:30 INFO - Running pre-action listener: _resource_record_pre_action 05:29:30 INFO - Running main action method: create_virtualenv 05:29:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:30 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:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:29:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:30 INFO - Using real prefix '/usr' 05:29:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:33 INFO - Installing pip.................done. 05:29:33 INFO - Return code: 0 05:29:33 INFO - Installing pip>=1.5 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', '--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 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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', '--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:33 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: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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 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 - 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:33 INFO - Cleaning up... 05:29:33 INFO - Return code: 0 05:29:33 INFO - Installing psutil>=0.7.1 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', '--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 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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', '--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:33 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: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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 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 - Downloading/unpacking psutil>=0.7.1 05:29:33 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:33 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:33 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:33 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:33 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:33 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:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:35 INFO - Installing collected packages: psutil 05:29:35 INFO - Running setup.py install for psutil 05:29:35 INFO - building 'psutil._psutil_linux' extension 05:29:35 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:35 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:35 INFO - building 'psutil._psutil_posix' extension 05:29:35 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:35 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:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:36 INFO - Successfully installed psutil 05:29:36 INFO - Cleaning up... 05:29:36 INFO - Return code: 0 05:29:36 INFO - Installing mozsystemmonitor==0.0.0 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', '--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 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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', '--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:36 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: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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 05:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:36 INFO - '_': '/tools/buildbot/bin/python'} 05:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:29:36 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:36 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 - 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:36 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:36 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:36 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:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:38 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:38 INFO - Installing collected packages: mozsystemmonitor 05:29:38 INFO - Running setup.py install for mozsystemmonitor 05:29:38 INFO - Successfully installed mozsystemmonitor 05:29:38 INFO - Cleaning up... 05:29:38 INFO - Return code: 0 05:29:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:29:38 INFO - Using env: {'DISPLAY': ':0', 05:29:38 INFO - 'HOME': '/home/cltbld', 05:29:38 INFO - 'LANG': 'en_US.UTF-8', 05:29:38 INFO - 'LANGUAGE': 'en_US:en', 05:29:38 INFO - 'LOGNAME': 'cltbld', 05:29:38 INFO - 'MAIL': '/var/mail/cltbld', 05:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:38 INFO - 'MOZ_NO_REMOTE': '1', 05:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:38 INFO - 'NO_EM_RESTART': '1', 05:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:38 INFO - 'PWD': '/builds/slave/test', 05:29:38 INFO - 'SHELL': '/bin/bash', 05:29:38 INFO - 'SHLVL': '1', 05:29:38 INFO - 'TERM': 'linux', 05:29:38 INFO - 'TMOUT': '86400', 05:29:38 INFO - 'USER': 'cltbld', 05:29:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 05:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:38 INFO - '_': '/tools/buildbot/bin/python'} 05:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:39 INFO - Downloading/unpacking blobuploader==1.2.4 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:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:29:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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 docopt-0.6.1.tar.gz 05:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:41 INFO - Running setup.py install for blobuploader 05:29:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:29:41 INFO - Running setup.py install for requests 05:29:42 INFO - Running setup.py install for docopt 05:29:42 INFO - Successfully installed blobuploader requests docopt 05:29:42 INFO - Cleaning up... 05:29:42 INFO - Return code: 0 05:29:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:42 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 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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:42 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:42 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:42 INFO - Using env: {'DISPLAY': ':0', 05:29:42 INFO - 'HOME': '/home/cltbld', 05:29:42 INFO - 'LANG': 'en_US.UTF-8', 05:29:42 INFO - 'LANGUAGE': 'en_US:en', 05:29:42 INFO - 'LOGNAME': 'cltbld', 05:29:42 INFO - 'MAIL': '/var/mail/cltbld', 05:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:42 INFO - 'MOZ_NO_REMOTE': '1', 05:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:42 INFO - 'NO_EM_RESTART': '1', 05:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:42 INFO - 'PWD': '/builds/slave/test', 05:29:42 INFO - 'SHELL': '/bin/bash', 05:29:42 INFO - 'SHLVL': '1', 05:29:42 INFO - 'TERM': 'linux', 05:29:42 INFO - 'TMOUT': '86400', 05:29:42 INFO - 'USER': 'cltbld', 05:29:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 05:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:42 INFO - '_': '/tools/buildbot/bin/python'} 05:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:42 INFO - Running setup.py (path:/tmp/pip-Peg_Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:42 INFO - Running setup.py (path:/tmp/pip-m3gOcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:42 INFO - Running setup.py (path:/tmp/pip-K3UqXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:42 INFO - Running setup.py (path:/tmp/pip-Ip7kkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:42 INFO - Running setup.py (path:/tmp/pip-LLfYrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:42 INFO - Running setup.py (path:/tmp/pip-XK9vwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:43 INFO - Running setup.py (path:/tmp/pip-_qhlAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:43 INFO - Running setup.py (path:/tmp/pip-PYLg3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:43 INFO - Running setup.py (path:/tmp/pip-pukizp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:43 INFO - Running setup.py (path:/tmp/pip-JcYj49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:43 INFO - Running setup.py (path:/tmp/pip-MxXj0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:43 INFO - Running setup.py (path:/tmp/pip-Ni9Wli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:43 INFO - Running setup.py (path:/tmp/pip-XXLnbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:43 INFO - Running setup.py (path:/tmp/pip-ChuMZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:43 INFO - Running setup.py (path:/tmp/pip-GMinrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:43 INFO - Running setup.py (path:/tmp/pip-PVoAbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:43 INFO - Running setup.py (path:/tmp/pip-fywPrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:29:43 INFO - Running setup.py install for manifestparser 05:29:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:29:43 INFO - Running setup.py install for mozcrash 05:29:43 INFO - Running setup.py install for mozdebug 05:29:44 INFO - Running setup.py install for mozdevice 05:29:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Running setup.py install for mozfile 05:29:44 INFO - Running setup.py install for mozhttpd 05:29:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Running setup.py install for mozinfo 05:29:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Running setup.py install for mozInstall 05:29:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Running setup.py install for mozleak 05:29:44 INFO - Running setup.py install for mozlog 05:29:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Running setup.py install for moznetwork 05:29:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:29:44 INFO - Running setup.py install for mozprocess 05:29:45 INFO - Running setup.py install for mozprofile 05:29:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:29:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:29:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:29:45 INFO - Running setup.py install for mozrunner 05:29:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:29:45 INFO - Running setup.py install for mozscreenshot 05:29:45 INFO - Running setup.py install for moztest 05:29:45 INFO - Running setup.py install for mozversion 05:29:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:29:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:29:45 INFO - Cleaning up... 05:29:45 INFO - Return code: 0 05:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:45 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 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 05:29:45 INFO - 'HOME': '/home/cltbld', 05:29:45 INFO - 'LANG': 'en_US.UTF-8', 05:29:45 INFO - 'LANGUAGE': 'en_US:en', 05:29:45 INFO - 'LOGNAME': 'cltbld', 05:29:45 INFO - 'MAIL': '/var/mail/cltbld', 05:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:45 INFO - 'MOZ_NO_REMOTE': '1', 05:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:45 INFO - 'NO_EM_RESTART': '1', 05:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:45 INFO - 'PWD': '/builds/slave/test', 05:29:45 INFO - 'SHELL': '/bin/bash', 05:29:45 INFO - 'SHLVL': '1', 05:29:45 INFO - 'TERM': 'linux', 05:29:45 INFO - 'TMOUT': '86400', 05:29:45 INFO - 'USER': 'cltbld', 05:29:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 05:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:45 INFO - '_': '/tools/buildbot/bin/python'} 05:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:45 INFO - Running setup.py (path:/tmp/pip-UleorH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:45 INFO - Running setup.py (path:/tmp/pip-sOB1N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:45 INFO - Running setup.py (path:/tmp/pip-NK1hrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:46 INFO - Running setup.py (path:/tmp/pip-iQg2uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:46 INFO - Running setup.py (path:/tmp/pip-pKRhd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:46 INFO - Running setup.py (path:/tmp/pip-nF5bAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:46 INFO - Running setup.py (path:/tmp/pip-tyYMzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:46 INFO - Running setup.py (path:/tmp/pip-mAm1w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:46 INFO - Running setup.py (path:/tmp/pip-E5UB6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:46 INFO - Running setup.py (path:/tmp/pip-Psd7Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:46 INFO - Running setup.py (path:/tmp/pip-SzcZUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:46 INFO - Running setup.py (path:/tmp/pip-IEzL4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:46 INFO - Running setup.py (path:/tmp/pip-0i0R2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:46 INFO - Running setup.py (path:/tmp/pip-uUA_Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:46 INFO - Running setup.py (path:/tmp/pip-7ZAKcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:46 INFO - Running setup.py (path:/tmp/pip-6pcVeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:46 INFO - Running setup.py (path:/tmp/pip-Xwohlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:47 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:47 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:47 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:47 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:47 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:47 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:48 INFO - Downloading blessings-1.6.tar.gz 05:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:29:48 INFO - Installing collected packages: blessings 05:29:48 INFO - Running setup.py install for blessings 05:29:49 INFO - Successfully installed blessings 05:29:49 INFO - Cleaning up... 05:29:49 INFO - Return code: 0 05:29:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:49 INFO - Reading from file tmpfile_stdout 05:29:49 INFO - Current package versions: 05:29:49 INFO - argparse == 1.2.1 05:29:49 INFO - blessings == 1.6 05:29:49 INFO - blobuploader == 1.2.4 05:29:49 INFO - docopt == 0.6.1 05:29:49 INFO - manifestparser == 1.1 05:29:49 INFO - mozInstall == 1.12 05:29:49 INFO - mozcrash == 0.17 05:29:49 INFO - mozdebug == 0.1 05:29:49 INFO - mozdevice == 0.48 05:29:49 INFO - mozfile == 1.2 05:29:49 INFO - mozhttpd == 0.7 05:29:49 INFO - mozinfo == 0.9 05:29:49 INFO - mozleak == 0.1 05:29:49 INFO - mozlog == 3.1 05:29:49 INFO - moznetwork == 0.27 05:29:49 INFO - mozprocess == 0.22 05:29:49 INFO - mozprofile == 0.28 05:29:49 INFO - mozrunner == 6.11 05:29:49 INFO - mozscreenshot == 0.1 05:29:49 INFO - mozsystemmonitor == 0.0 05:29:49 INFO - moztest == 0.7 05:29:49 INFO - mozversion == 1.4 05:29:49 INFO - psutil == 3.1.1 05:29:49 INFO - requests == 1.2.3 05:29:49 INFO - wsgiref == 0.1.2 05:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:49 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 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 05:29:49 INFO - 'HOME': '/home/cltbld', 05:29:49 INFO - 'LANG': 'en_US.UTF-8', 05:29:49 INFO - 'LANGUAGE': 'en_US:en', 05:29:49 INFO - 'LOGNAME': 'cltbld', 05:29:49 INFO - 'MAIL': '/var/mail/cltbld', 05:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:49 INFO - 'MOZ_NO_REMOTE': '1', 05:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:49 INFO - 'NO_EM_RESTART': '1', 05:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:49 INFO - 'PWD': '/builds/slave/test', 05:29:49 INFO - 'SHELL': '/bin/bash', 05:29:49 INFO - 'SHLVL': '1', 05:29:49 INFO - 'TERM': 'linux', 05:29:49 INFO - 'TMOUT': '86400', 05:29:49 INFO - 'USER': 'cltbld', 05:29:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 05:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:49 INFO - '_': '/tools/buildbot/bin/python'} 05:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 INFO - Cleaning up... 05:29:49 INFO - Return code: 0 05:29:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:49 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 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 05:29:49 INFO - 'HOME': '/home/cltbld', 05:29:49 INFO - 'LANG': 'en_US.UTF-8', 05:29:49 INFO - 'LANGUAGE': 'en_US:en', 05:29:49 INFO - 'LOGNAME': 'cltbld', 05:29:49 INFO - 'MAIL': '/var/mail/cltbld', 05:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:49 INFO - 'MOZ_NO_REMOTE': '1', 05:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:49 INFO - 'NO_EM_RESTART': '1', 05:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:49 INFO - 'PWD': '/builds/slave/test', 05:29:49 INFO - 'SHELL': '/bin/bash', 05:29:49 INFO - 'SHLVL': '1', 05:29:49 INFO - 'TERM': 'linux', 05:29:49 INFO - 'TMOUT': '86400', 05:29:49 INFO - 'USER': 'cltbld', 05:29:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 05:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:49 INFO - '_': '/tools/buildbot/bin/python'} 05:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:49 INFO - Downloading/unpacking jsonschema 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:29:51 INFO - Downloading/unpacking functools32 (from jsonschema) 05:29:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:29:51 INFO - warning: no files found matching '*.txt' 05:29:51 INFO - no previously-included directories found matching 'build' 05:29:51 INFO - no previously-included directories found matching 'dist' 05:29:51 INFO - no previously-included directories found matching '.git*' 05:29:51 INFO - Installing collected packages: jsonschema, functools32 05:29:51 INFO - Running setup.py install for functools32 05:29:51 INFO - warning: no files found matching '*.txt' 05:29:51 INFO - no previously-included directories found matching 'build' 05:29:51 INFO - no previously-included directories found matching 'dist' 05:29:51 INFO - no previously-included directories found matching '.git*' 05:29:52 INFO - Successfully installed jsonschema functools32 05:29:52 INFO - Cleaning up... 05:29:52 INFO - Return code: 0 05:29:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe4a883f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', '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:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:29:52 INFO - Using env: {'DISPLAY': ':0', 05:29:52 INFO - 'HOME': '/home/cltbld', 05:29:52 INFO - 'LANG': 'en_US.UTF-8', 05:29:52 INFO - 'LANGUAGE': 'en_US:en', 05:29:52 INFO - 'LOGNAME': 'cltbld', 05:29:52 INFO - 'MAIL': '/var/mail/cltbld', 05:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:52 INFO - 'MOZ_NO_REMOTE': '1', 05:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:52 INFO - 'NO_EM_RESTART': '1', 05:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:52 INFO - 'PWD': '/builds/slave/test', 05:29:52 INFO - 'SHELL': '/bin/bash', 05:29:52 INFO - 'SHLVL': '1', 05:29:52 INFO - 'TERM': 'linux', 05:29:52 INFO - 'TMOUT': '86400', 05:29:52 INFO - 'USER': 'cltbld', 05:29:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 05:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:52 INFO - '_': '/tools/buildbot/bin/python'} 05:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:52 INFO - Downloading/unpacking flake8 05:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:29:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:29:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:29:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:29:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:29:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:29:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:29:54 INFO - no previously-included directories found matching 'docs/_build' 05:29:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:29:54 INFO - Running setup.py install for pep8 05:29:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:29:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:29:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:29:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:29:54 INFO - no previously-included directories found matching 'docs/_build' 05:29:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:29:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:29:54 INFO - Cleaning up... 05:29:55 INFO - Return code: 0 05:29:55 INFO - Running post-action listener: _resource_record_post_action 05:29:55 INFO - Running post-action listener: _start_resource_monitoring 05:29:55 INFO - Starting resource monitoring. 05:29:55 INFO - ##### 05:29:55 INFO - ##### Running install step. 05:29:55 INFO - ##### 05:29:55 INFO - Running pre-action listener: _resource_record_pre_action 05:29:55 INFO - Running main action method: install 05:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:55 INFO - Reading from file tmpfile_stdout 05:29:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:29:55 INFO - Reading from file tmpfile_stdout 05:29:55 INFO - Output received: 05:29:55 INFO - Usage: mozinstall [options] installer 05:29:55 INFO - Options: 05:29:55 INFO - -h, --help show this help message and exit 05:29:55 INFO - -d DEST, --destination=DEST 05:29:55 INFO - Directory to install application into. [default: 05:29:55 INFO - "/builds/slave/test"] 05:29:55 INFO - --app=APP Application being installed. [default: firefox] 05:29:55 INFO - mkdir: /builds/slave/test/build/application 05:29:55 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:55 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:30:11 INFO - Reading from file tmpfile_stdout 05:30:11 INFO - Output received: 05:30:11 INFO - /builds/slave/test/build/application/firefox/firefox 05:30:11 INFO - Running post-action listener: _resource_record_post_action 05:30:11 INFO - ##### 05:30:11 INFO - ##### Running run-tests step. 05:30:11 INFO - ##### 05:30:11 INFO - Running pre-action listener: _resource_record_pre_action 05:30:11 INFO - Running main action method: run_tests 05:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:11 INFO - Python 2.7.3 05:30:11 INFO - Return code: 0 05:30:11 INFO - grabbing minidump binary from tooltool 05:30:11 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:30:11 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 0x1e5f160>, '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 0x1e60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e604f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:11 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:30:11 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:30:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:11 INFO - Return code: 0 05:30:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:30:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:30:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:30:12 INFO - Return code: 0 05:30:12 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-010', '--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:30:12 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-010 --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:30:12 INFO - Using env: {'DISPLAY': ':0', 05:30:12 INFO - 'HOME': '/home/cltbld', 05:30:12 INFO - 'LANG': 'en_US.UTF-8', 05:30:12 INFO - 'LANGUAGE': 'en_US:en', 05:30:12 INFO - 'LOGNAME': 'cltbld', 05:30:12 INFO - 'MAIL': '/var/mail/cltbld', 05:30:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:12 INFO - 'MOZ_NO_REMOTE': '1', 05:30:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:12 INFO - 'NO_EM_RESTART': '1', 05:30:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:12 INFO - 'PWD': '/builds/slave/test', 05:30:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:12 INFO - 'SHELL': '/bin/bash', 05:30:12 INFO - 'SHLVL': '1', 05:30:12 INFO - 'TERM': 'linux', 05:30:12 INFO - 'TMOUT': '86400', 05:30:12 INFO - 'USER': 'cltbld', 05:30:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409', 05:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:12 INFO - '_': '/tools/buildbot/bin/python'} 05:30:12 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-010', '--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:12 INFO - mozversion application_buildid: 20160310025316 05:30:12 INFO - mozversion application_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 05:30:12 INFO - mozversion application_display_name: Nightly 05:30:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:12 INFO - mozversion application_name: Firefox 05:30:12 INFO - mozversion application_remotingname: firefox 05:30:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:30:12 INFO - mozversion application_vendor: Mozilla 05:30:12 INFO - mozversion application_version: 48.0a1 05:30:12 INFO - mozversion platform_buildid: 20160310025316 05:30:12 INFO - mozversion platform_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 05:30:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:30:12 INFO - mozversion platform_version: 48.0a1 05:30:12 INFO - using testdate: 1457616612 05:30:12 INFO - actual date: 1457616612 05:30:12 INFO - starting webserver on 'localhost:32943' 05:30:12 INFO - SUITE-START | Running 2 tests 05:30:12 INFO - TEST-START | dromaeo_css 05:30:12 INFO - operating with platform_type : linux_ 05:30:12 INFO - Initialising browser for dromaeo_css test... 05:30:12 INFO - TEST-INFO | started process 27558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlfnfm/profile http://localhost:32943/getInfo.html) 05:30:17 INFO - PROCESS | 27558 | __metrics Screen width/height:1600/1200 05:30:17 INFO - PROCESS | 27558 | colorDepth:24 05:30:17 INFO - PROCESS | 27558 | Browser inner width/height: 1024/697 05:30:17 INFO - PROCESS | 27558 | __metrics 05:30:18 ERROR - PROCESS | 27558 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:30:19 INFO - TEST-INFO | 27558: exit 0 05:30:19 INFO - Browser initialized. 05:30:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:30:19 INFO - TEST-INFO | started process 27650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnlfnfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:31 INFO - PROCESS | 27650 | RSS: Main: 154480640 05:30:31 INFO - PROCESS | 27650 | 05:31:22 INFO - PROCESS | 27650 | 1457616682937 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:34 INFO - PROCESS | 27650 | Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32943/tests/dromaeo/cssquery-ext.html) 05:33:35 INFO - PROCESS | 27650 | RSS: Main: 242020352 05:33:35 INFO - PROCESS | 27650 | 05:36:37 INFO - PROCESS | 27650 | Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-ext.html (next: http://localhost:32943/tests/dromaeo/cssquery-jquery.html) 05:36:38 INFO - PROCESS | 27650 | RSS: Main: 235786240 05:36:38 INFO - PROCESS | 27650 | 05:39:40 INFO - PROCESS | 27650 | Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32943/tests/dromaeo/cssquery-mootools.html) 05:39:40 INFO - PROCESS | 27650 | RSS: Main: 234745856 05:39:40 INFO - PROCESS | 27650 | 05:42:42 INFO - PROCESS | 27650 | Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32943/tests/dromaeo/cssquery-prototype.html) 05:42:43 INFO - PROCESS | 27650 | RSS: Main: 199331840 05:42:43 INFO - PROCESS | 27650 | 05:45:45 INFO - PROCESS | 27650 | Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32943/tests/dromaeo/cssquery-yui.html) 05:45:46 INFO - PROCESS | 27650 | RSS: Main: 194191360 05:45:46 INFO - PROCESS | 27650 | 05:48:48 INFO - PROCESS | 27650 | Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-yui.html (next: http://localhost:32943/tests/dromaeo/cssquery-dojo.html) 05:48:49 INFO - PROCESS | 27650 | RSS: Main: 265834496 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - PROCESS | 27650 | __start_tp_report 05:48:49 INFO - PROCESS | 27650 | _x_x_mozilla_page_load 05:48:49 INFO - PROCESS | 27650 | _x_x_mozilla_page_load_details 05:48:49 INFO - PROCESS | 27650 | |i|pagename|runs| 05:48:49 INFO - PROCESS | 27650 | |0;dojo.html;2571.2660766490726;2638.089858998646;2654.8938042478303;2668.7197844226357;2687.046098634984;4402.3836662867225;4456.910861782762;4474.686771925963;4498.730076195427;4539.614132798716;4433.667474939376;4486.237339652259;4499.280115181572;4512.323151527265;4559.794809233585;4138.13099249158;4169.937450938246;4250.192463431938;4291.8497852575165;4308.82764689412;4059.106996460774;4215.156968606291;4240.151969606076;4260.446142001535;4272.188284225987;4112.198121366319;4147.191297696951;4147.958520414818;4189.476315460567;4197.034682023152;4136.689748268862;4143.875683729493;4167.187398457302;4179.97910010448;4182.309918863384;4073.429719839225;4141.813618387149;4151.771652559108;4153.501579810442;4198;4367.956320436787;4389.495208051083;4410.955890441087;4443.4445694288215;4453.465584129893;4791.401074865642;4805.014971930746;4812.518748125194;4820.517948205152;4820.879478013043;4752.5485078917445;4767.785449654774;4833.250846118857;4855.562999330042;4886.242632391985;4540.0011997360525;4540.273556230987;4567.771611419482;4568.862934111982;4585.037142200175;4973.701577905337;4974.502549745069;4976.278439626306;4977.8257760978195;4978.253262010728;4656.208444564364;4706.858794236178;4782.593479554207;4787.736674482937;4822.300766388854;4779.545943135466;4800.855974320776;4809.374781278411;4830.227163653799;4837.540433658867;4735.526447355306;4749.430068391815;4752.097101550694;4754.595859351924;4791.185498465269;4569.817207311737;4737.313089601988;4753.904921901542;4814.037192561502;4826.831060912851;4023.8390464381096;4032.737872038308;4040.393940908887;4059.7564146151326;4083.387491876183;3578.355895938756;3583.7849729016343;3589.4615807628543;3591.3894637911617;3612.8193590320902;4022.537408198095;4094.897627559335;4124.587541245912;4182.079942412664;4183.393407955829;4776.474587795409;4789.066132104276;4809.615230781529;4810.134175848311;4845.927311090337;4163.333866581393;4170.270202714512;4171.520275168395;4204.873853784391;4206.390073439396;4187.874363769091;4305.117450922616;4322.827086916551;4335.566443355639;4357.9128417431475;4486.730796152241;4497.730136191839;4506.143832671782;4512.526184750685;4542.545745425497;4701.7414042228;4741.099191153669;4742.336072949721;4746.833860814855;4783.354247176726;4520.18636645407;4559.475660299108;4561.224591819465;4585.885352866205;4596.747178905192;4708.419444693972;4710.64670149747;4712.128256272601;4713.340132381538;4735.242361222188;4710.858674239778;4764.142454358249;4767.833125840579;4774.474807771212;4813.5186481352985;4648.2562789953445;4662.347271381941;4676.836310729108;4677.251639737626;4719.339292498984;4668.836590719445;4670.369500117441;4671.135839869635;4707.929381059355;4721.669483136147;4439.178751930903;4471.06107717383;4577.633789296915;4592.402987611589;4603.194440972749;4643;4655.20861453547;4659.021605462891;4691.577758001797;4703.576678098988;4517.232070547949;4519.096180763795;4519.502854685916;4557.658175636774;4558.794854231502 05:48:49 INFO - PROCESS | 27650 | |1;ext.html;492.9753512324383;502.4724039758253;553.3553410277027;553.5626854784721;564.2664536103067;25269.74730252697;25951.221463356083;33907.32185356294;34481.482777758356;34527.82736086316;37341.43987840185;37811.432828507524;38001.429978550346;38006.4299035514;38089;7630.0843898731955;7794.142644309121;7794.259545343211;7800.297973182441;7809.140994490602;7585;7649.579273139975;7699.960505331793;7702.26828451299;7706.6146692665425;7693.961530192341;7744.496607720508;7922.049354077519;7929.960350198241;7955.72154974576;7858.567778772165;7903.762887113338;7925.0489941207425;7929.682812687543;7931.484453510532;7898.447108702393;8027.197280271985;8027.678892844279;8029.116797152308;8033.919660803375;37923.241535169414;38369.61630383688;38370.808145959374;38426.231475370616;38472.422913656315;2889.8699558519916;2924.7075292470795;2937.3097322129283;2979.002034318506;3019.4866872631706;28061.859690701414;28310.575341369895;28388.290292742848;28570.857145714348;29311.41377172466;3433.8626454941773;3477.061193477772;3488.459288810213;3510.3514803730045;3526.4710293455933;210085;210225.99999999846;210239;210804;210984;54203.18695219575;54228.45771542313;54571;54620.72689636606;54656;57320.42679573235;57495.42504574984;57501;62252;63381.68309158517;14289.428422863177;14529.491467798576;14539.709205815825;14546.127232366092;14551.854481455262;10997.890021099687;11053;11083.224174307883;11094.55621775136;11099.667009989713;19330.702966395405;19592.314269000515;20131.19475221004;20164.092615832324;20197.899010504854;7925.564093974886;8077.869098326239;8105.1489593593005;8134.633941472648;8174.877376839352;801.5711594297023;810.491528718615;845.2815107158989;943;1006.6074231049896;24237.151699690425;25612.231633051037;26137.869310653707;26514;26715.465690686466;915.8351496730652;943.1228957069991;955.245356168633;988.4958671077802;1025.4308858583559;13671.316434178252;13899.166050036827;13970.790438143233;13993.930030349784;14038.438462461592;301443;305432;308451;308627;309017;48982;50278.24582631263;50416.24375634368;50690.493095069316;50769.238461423105;1126.971825704364;1193.254216114928;1210.727586293077;1230.6000549821345;1234.5925844471483;26638.600420994087;27690;28740.137795866158;30011.249718757204;30691.2327191822;39855.40216896807;40473.79763101166;41173.588264116974;41183.176336472505;41227.79386103051;230846;238285;238471;238485;238647;32004.839975799972;39703;39911.40132897951;40502.79748601238;40878.38682419706;38367.808160959015;39294.803525983334;39837.40243896402;39881.401778973915;42401.36397953972;33243.335133296714;33597.496037558965;33652.663473364955;34222.31555368929;34503.4824477638;35943;36648.45027324539;36770;37099.629003710696;37136;35969.64030359663;36232.818835906706;36368.27263454769;36597.268054638225;36698.082547936516;32122.839385802923;32600;32724.836375818923;32792.34415311728;32907.341853162325;25521.361965951;25565.23304300874;25641.871790640926;25678.614820778075;25822.61266081048 05:48:49 INFO - PROCESS | 27650 | |2;jquery.html;324.508369819723;332.6067810453497;336.1763678986483;336.74912190418144;337.5898283585443;14602.342894569756;15108;15661.843381566181;15773.921130394332;15808.762868556982;14376.49682261121;14736.852631473683;14981.325840337184;15822.129782861937;15832.920835395837;4950.727709975941;5149.0731668299695;5150.4334523202415;5151.845444636649;5157.5358217760395;4933.260010998343;5025.271335656327;5049.192129259319;5078.7968481260705;5109.080365534202;5039.596832253429;5042.747862606873;5043.470435604264;5043.84868453947;5053.797848086072;4858.659893807418;5006.123928312531;5022.547970682638;5025.3718285214345;5065.898682026339;4477.888052798674;4488.5960263576435;4492.101579684044;4508.819647214107;4512.029913568598;17966.820331796775;18487.722684159748;18707;18730.719039214422;18741.7188742169;1781.7950935642436;1857.2385322017908;1896.2888916656254;2188.1684959715367;2384.0821283805685;12007.159498835084;12100;12138.271703697717;12183.695407614792;12288.139830211889;1724.7412888066765;1758.4285107340038;1763.9735403968823;1792.9551761205944;1851.426057922035;53737.462625373635;55624;57074;57153.428465715224;57689;8929.464232145961;8981.371304008657;9106.18044375996;9127.634894604274;9255.768605784775;11666.416679166177;11740.589079382351;11755;11766.117541184445;11770.88229117715;7050.189228238715;7098.219195888448;7118.822029449305;7242.6378681065735;7250.16623088341;7106.395956343666;7143.785686429415;7147.749828755968;7195.640217989079;7243.927560724431;5461.399246082928;5573.944260557424;5595.608307418523;5596.58025648078;5671.638806686366;1612.8387161284013;1650.5708515785982;1651.174412793603;1662.684090022916;1662.9002259864446;787.2009909941414;829.2660995019452;872.8777971084053;927.8376284150247;951.9100629779002;15230.695386092217;15688.450904218298;15736.763948540782;15803.130827804582;15848;819.2012787532227;885.6900084970209;910.4036855859423;947.5688561704408;956.4739393333639;8030.196980301923;8124.390670699603;8257.504549727035;8258.793530161674;8367.121452247547;368261;377054;377629;381435;383822;44427.55572444234;54266.728666356415;58590.707046465344;63429;67021;863.9438436501607;946.2477330522252;946.3328353510758;987.1214618989105;988.1304452082122;11424.657260282205;13564.38960246811;14257;14335.713285734435;14378.856211437751;31721.365572687955;33499.33001339911;33711.157221068686;34093.659063409046;34127.31745365029;43672;46527.30209046935;46900.7654961723;46909;47068;6918.377346038881;6960.338767817049;6988.545744526589;7023.3678968891;7054.929450705633;7969.083555391204;10367.429791361548;10599.788004239717;10694.465276735977;10763.192760543147;9253.86119208199;9323.813523729623;9429.905700942903;9492.335536512377;9903.702888913343;9503.23974082058;9521.333506654468;9576.664816731382;9650.565724542272;9659.71020869375;8881.866771998555;9082.137196966278;9338.066193380608;9492.572834222614;9612.231021518122;6970;7015.859682806214;7116.359527642537;7123.82190445243;7180.748673796392;7644.847103058019;9019.549022548716;9044.41211321262;9077.409968352036;9175.587098580714 05:48:49 INFO - PROCESS | 27650 | |3;mootools.html;1262.3246563088737;1412.0398129272094;1430.9713805723886;1602.679464107178;1809.7828260608721;7202;7294.708211671526;7331.7433889813865;7336.486445948779;7337.339639432456;7185.89221161683;7374.631268436584;7383.48315617907;7390.556566606007;7395.70417183312;1731.3334366269014;2108.11459187141;2110.2403134871433;2132.1577976699195;2178.2593918067855;2175.1516908405733;2187.1798075721604;2187.4093994621444;2189.5730332585154;2191.671249312608;2056.856020078595;2079.189116244666;2080.4278823323557;2081.6669332906736;2086.1863873089505;2053.9897300513476;2054.085931760367;2068.11071239367;2155.7844215578475;2174.6737989301573;2130.7017017617545;2161.848670593059;2166.7183266175452;2173.4240426287047;2178.063432723928;7538.321551060376;7597.848043039108;7615.7334493292465;7616.0860696716745;7618.238176182393;4241.300185469394;4334.783260836977;4337.110892267077;4356.803943822536;4359.585839345257;2736.1107640016876;2804.9859750701116;2862.4561333346805;2867.813592116506;2898.68114507404;879.8636211387245;883.4434306387;892.2237653241722;912.3522299167532;917.7200953709116;10588.735281617945;10655.200859935536;10663.253572249945;10667.626633067883;10686.358818470839;3943.152222272225;4064.7154699171365;4103.9179216416105;4109.2808758467145;4158.480189976253;8795.296376289882;8829.470231786114;8844.380893337533;8865.024847266795;8878.067802880734;3879.4568760373572;4420.513743488214;4420.756858372756;4427.867163985085;4430.224710675619;3913.1195481016543;3986.043349596076;3986.421968814506;4002;4010.137820368635;3398.4392575225306;3441.397755392796;3490.6334834842482;3509.6841284284537;3521.207728261121;1105.3533682795655;1107.9446027698743;1116.1963386361806;1118.6532175025768;1119.8040342939953;1171.5614670940815;1173.0908545876844;1184.8755880632582;1190.4642910690052;1198.8081906894854;7098.68055937484;7142.714291428389;7180.210176880539;7193.460490463236;7206.531575447579;436.147331966012;451.11131071788526;451.37033837796747;451.4199253958713;452.4457539514069;5375.166849138312;5401.972990135024;5404.081306177959;5411.783528658888;5429.56563474921;8559.186877246651;8712.520811355436;8869.11308869108;8888.60001299943;8908.73273801787;8765.123487651312;8813.823723525493;8884.333674974403;8892.73321800347;8892.911070889208;6803.081583986197;6818.488613353919;6959.478039146983;6960.79117626472;7002.1947476040905;6913.1358580177475;6926.272741362286;6975.546589471668;6979.441644668516;6995.125609298838;8008;8263.173682631688;8296.253337199681;8355.415120941476;8478.83042339162;8386.412951093365;8697.826043478968;8711.25954293892;8717.346199035224;8786.384953053224;6434.613923164625;6495;6609;6634.568753031231;6636.303188165173;7224.566526008456;7238.420926325776;7281.490295679251;7281.708731650887;7321.158066822383;6303.086052522267;6426.42162205385;6477.352264773485;6542.8364290893105;6609.966950165219;6054.878902422015;6095.664738439428;6222.471089957405;6240.4071613196675;6350.555461117678;6453.741850325934;6486.481081513373;6493.415592596689;6521.836954076186;6538.738450461929;5919.141724449844;5976.8804623908145;6021.397860214119;6032.487238584769;6069.939300607114;6146.477549408351;6193;6213.813585592439;6222.688865556795;6227.782027629011 05:48:49 INFO - PROCESS | 27650 | |4;prototype.html;299.8305957134219;303.80556443875923;304.4732612580236;305.89293747188503;308.62502059997115;5188.0920838853235;5232.16285394337;5245.501677340656;5357.142857142858;5370;5161.819336323229;5175.974120129404;5230.555402790757;5256.474352564742;5267.051930652481;3828.464015037897;3877.4377715231276;4026.0136266614722;4055.209234199325;4067.959320406788;4028.9597104028876;4029.0531725044593;4035.4552135461777;4037.9192416151805;4043.0498832774274;3970.067034246964;3972.682185425159;3979.820908059144;3982.8406863725418;3987.262356464049;3810.8856734298015;3881;3964.8215830287704;3991.102002049545;4006.8998275043064;3457.429524128516;3459.08334291413;3468.1849765305133;3468.3410152071024;3471.878484253039;5016.3980322361185;5017.874553136201;5034.043531728959;5040.697558146523;5041.747912604355;4560.201964656172;4566.794494247767;4568.2462393705;4571.154336447735;4578;5457.672539647594;5468.507834294893;5470.152126420411;5473.917891231635;5482.396936337;3776.622337766229;3777.301199278142;3777.9055523611855;3778.301014312361;3784.6593806557266;5612.663240205601;5664.915026274609;5689.260396148516;5751.971240143815;5755.683437410982;3835.9424608630893;3845.288621605012;3855.094052897567;3869.9744567689586;3872.4772155759174;3911.5501717302304;3916;3921.5882332355263;3923.843046278117;3926.764394136361;4525.683202175882;4529.818807247673;4535.931961020588;4536.206163921301;4550.453945526492;5485.725713714299;5492.80775172867;5493.533049690741;5494.2857428534835;5496.835094947158;1365.1604263377951;1393.0736060519844;1395.0931894268806;1396.860313968595;1397.2035939514583;858.4505916213628;899.3929097858919;920.5489310237936;954.1222075690381;954.1508057828538;4720.173969555314;4806.903861922742;4808.230683090758;4810.759462026885;4813.566778989908;5621.8594535136945;5629.493345598834;5631.6902570359025;5636.887262254732;5637.267155269788;4837.854864354075;4842.58837998774;4843.038569379407;4849.127157111754;4859.562639362474;3007.9248018799267;3039.1642298368124;3051.023672424847;3057.975578181334;3065.662777094518;5350.652207606493;5358.062339090644;5366.221897824794;5374.785008599612;5382.3541175059245;5663;5848.064309710426;5857.619254748428;5878.2358293421585;5880;5346.652467589594;5372.435894231127;5373.704446255337;5377.596680248997;5380;5704.771809127755;5708.372079071381;5708.8572785679025;5714.285714285715;5715.828525144252;5584.609077364546;5584.720763961867;5594.244776955059;5601.579881508985;5604.943950560605;5362.463753624606;5369.624126311121;5370.516653501204;5372.946270537244;5377.865553361197;3755.7370984030854;3874.1670540833857;3877.786721730332;3886.6113388660906;3895.6883449324555;5686.118651609007;5689.914651280317;5734;5746.655200687972;5749.568782341257;5443.863903402446;5456.536194423518;5459.563234941115;5468.589855760913;5470.288862447856;5452.809151679672;5455.727213639223;5457.781688732565;5460.508554229979;5463.7814487420055;5351.678899266057;5355;5363.597730170175;5366.946330536801;5368.033753924331;5346.117890548016;5494.066008778597;5504.4770746778995;5513.448655134454;5514.310711161105;5271.20931860224;5287.735613219401;5290.047791397586;5292.20616907467;5296.232046353334 05:48:49 INFO - PROCESS | 27650 | |5;yui.html;653.7875190563066;698.9650517474125;731.4989232375826;739.2496615934826;757.8673732096884;11777.587784427547;11889.989350905184;11894.04847612191;11899.286042837435;11904.940475297622;11781.23421977573;11850.466728997195;13523.256220907846;13753.106048106865;13756.793648095287;800.5516910530092;818.5211651184035;819.0580832043169;819.1480859905691;819.6434550970317;625.6277514878662;807.4347956430522;829.050736906242;832.1054866019024;833.0919297965216;862.6549380247919;864.4078806017866;864.6671031652796;865.9523726195057;866.0603245478632;647.5920170292685;862.3316929379781;862.525610913998;862.9741107766746;863.0420233540733;623.9282482514524;637.8692368064536;638.5530128909735;638.9488840892717;639.2840019178503;12266.509339626404;12325;12350.073744469111;12354;12354.135210535265;11171.121220971972;11787.292762434281;11804.586839460664;11917.582884599084;11993.460294286691;9543.904560954372;9582.856257156149;9708.271879609058;9760.170385517169;9880.654177103766;3268.0686004488844;3291.9341613167603;3299.5050742388594;3351.262722201112;3388.457846744509;42570.36144457835;42917.78541107274;42941.785291073655;42947.35578966318;42994.14011719779;9278.628854845865;9428.387154834914;9462.195713364303;9577.139213263725;9613.086756758097;16498.83501164997;16552.75170872438;16600.6679866402;16634.25145868439;16657.83342166563;6429.9678501607195;6486.67566621667;6507.772227971998;6590.703418346186;6610.669466526654;3570.143165640228;3570.8571657133944;3600.963990360063;3619.2037751694584;3624.474451204613;2868.8995885144336;2868.9713102868704;2898.869550870216;2904.8257104573795;2905.7675385969073;492.6428339453867;503.3280570438433;513.1225604216831;513.1968469345462;519.0605004940993;439.8966242932908;600.7446835095154;602.8312072619674;618.040859917334;618.3630860213987;7493.100827900578;7591.810204744815;7880.290773830383;8109.797255068553;8259.38054645904;458.1455585333329;558.8682917092838;601.1223613524304;603.3996173807002;619.6344156947423;3567.8037707926314;3677.6506231907924;3687.778733276012;3807.238552289498;3844.231153769257;46632.7668361656;46879.29681054787;46991.530084698716;47097.76451117722;47105.293420598035;37982.620173797906;38153.61846381556;38269.80865095712;38372.808135959145;38457.807710961264;35869.8206508971;35925.46111808325;36495.99999999947;37386.8130659345;37465.81267093647;7967.880481792662;8063.959680201561;8197.46716463428;8202.753917382488;8405.369597280107;29515.409691805613;29594.999999999138;30132.84933575318;30247;30774.538381924736;33615.15962100967;33768.324633507684;37080.25839483141;39197.6080239194;39310.60689393069;10559.577616895238;10575.206859485415;10716.303440276357;10722.73193170177;11361.375124367909;11074.778504430027;11083.778324433628;11305.660830175108;11441.199116061796;11653.533858645898;9686.515674216402;10022.899771002196;10090.2432317575;10626.415547144981;10667.253292269466;10829.891701082888;10998.505067272152;11085.22403431752;11152.442377881236;11616.88383116158;10327.741806454898;10489.685309440729;10508.106810921157;10726.570937162425;10752.193585481276;9738.269629777653;9753.9024609753;10033.749156271151;10118.368440374301;10209.234307426825;9019.5039272838;9446.95276523613;9601.807963840545;9723.756906077404;9728.319017668695 05:48:49 INFO - PROCESS | 27650 | __end_tp_report 05:48:49 INFO - PROCESS | 27650 | __start_cc_report 05:48:49 INFO - PROCESS | 27650 | _x_x_mozilla_cycle_collect,825 05:48:49 INFO - PROCESS | 27650 | __end_cc_report 05:48:49 INFO - PROCESS | 27650 | __startTimestamp1457617729187__endTimestamp 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - PROCESS | 27650 | ------- Summary: start ------- 05:48:49 INFO - PROCESS | 27650 | Number of tests: 6 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - PROCESS | 27650 | [#0] dojo.html Cycles:165 Average:4442.98 Median:4557.66 stddev:438.66 (9.6%) stddev-sans-first:414.70 05:48:49 INFO - PROCESS | 27650 | Values: 2571.3 2638.1 2654.9 2668.7 2687.0 4402.4 4456.9 4474.7 4498.7 4539.6 4433.7 4486.2 4499.3 4512.3 4559.8 4138.1 4169.9 4250.2 4291.8 4308.8 4059.1 4215.2 4240.2 4260.4 4272.2 4112.2 4147.2 4148.0 4189.5 4197.0 4136.7 4143.9 4167.2 4180.0 4182.3 4073.4 4141.8 4151.8 4153.5 4198.0 4368.0 4389.5 4411.0 4443.4 4453.5 4791.4 4805.0 4812.5 4820.5 4820.9 4752.5 4767.8 4833.3 4855.6 4886.2 4540.0 4540.3 4567.8 4568.9 4585.0 4973.7 4974.5 4976.3 4977.8 4978.3 4656.2 4706.9 4782.6 4787.7 4822.3 4779.5 4800.9 4809.4 4830.2 4837.5 4735.5 4749.4 4752.1 4754.6 4791.2 4569.8 4737.3 4753.9 4814.0 4826.8 4023.8 4032.7 4040.4 4059.8 4083.4 3578.4 3583.8 3589.5 3591.4 3612.8 4022.5 4094.9 4124.6 4182.1 4183.4 4776.5 4789.1 4809.6 4810.1 4845.9 4163.3 4170.3 4171.5 4204.9 4206.4 4187.9 4305.1 4322.8 4335.6 4357.9 4486.7 4497.7 4506.1 4512.5 4542.5 4701.7 4741.1 4742.3 4746.8 4783.4 4520.2 4559.5 4561.2 4585.9 4596.7 4708.4 4710.6 4712.1 4713.3 4735.2 4710.9 4764.1 4767.8 4774.5 4813.5 4648.3 4662.3 4676.8 4677.3 4719.3 4668.8 4670.4 4671.1 4707.9 4721.7 4439.2 4471.1 4577.6 4592.4 4603.2 4643.0 4655.2 4659.0 4691.6 4703.6 4517.2 4519.1 4519.5 4557.7 4558.8 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - PROCESS | 27650 | [#1] ext.html Cycles:180 Average:41933.36 Median:36300.55 stddev:66434.34 (183.0%) stddev-sans-first:66547.84 05:48:49 INFO - PROCESS | 27650 | Values: 493.0 502.5 553.4 553.6 564.3 25269.7 25951.2 33907.3 34481.5 34527.8 37341.4 37811.4 38001.4 38006.4 38089.0 7630.1 7794.1 7794.3 7800.3 7809.1 7585.0 7649.6 7700.0 7702.3 7706.6 7694.0 7744.5 7922.0 7930.0 7955.7 7858.6 7903.8 7925.0 7929.7 7931.5 7898.4 8027.2 8027.7 8029.1 8033.9 37923.2 38369.6 38370.8 38426.2 38472.4 2889.9 2924.7 2937.3 2979.0 3019.5 28061.9 28310.6 28388.3 28570.9 29311.4 3433.9 3477.1 3488.5 3510.4 3526.5 210085.0 210226.0 210239.0 210804.0 210984.0 54203.2 54228.5 54571.0 54620.7 54656.0 57320.4 57495.4 57501.0 62252.0 63381.7 14289.4 14529.5 14539.7 14546.1 14551.9 10997.9 11053.0 11083.2 11094.6 11099.7 19330.7 19592.3 20131.2 20164.1 20197.9 7925.6 8077.9 8105.1 8134.6 8174.9 801.6 810.5 845.3 943.0 1006.6 24237.2 25612.2 26137.9 26514.0 26715.5 915.8 943.1 955.2 988.5 1025.4 13671.3 13899.2 13970.8 13993.9 14038.4 301443.0 305432.0 308451.0 308627.0 309017.0 48982.0 50278.2 50416.2 50690.5 50769.2 1127.0 1193.3 1210.7 1230.6 1234.6 26638.6 27690.0 28740.1 30011.2 30691.2 39855.4 40473.8 41173.6 41183.2 41227.8 230846.0 238285.0 238471.0 238485.0 238647.0 32004.8 39703.0 39911.4 40502.8 40878.4 38367.8 39294.8 39837.4 39881.4 42401.4 33243.3 33597.5 33652.7 34222.3 34503.5 35943.0 36648.5 36770.0 37099.6 37136.0 35969.6 36232.8 36368.3 36597.3 36698.1 32122.8 32600.0 32724.8 32792.3 32907.3 25521.4 25565.2 25641.9 25678.6 25822.6 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - PROCESS | 27650 | [#2] jquery.html Cycles:180 Average:22359.97 Median:5046.52 stddev:61845.44 (1225.5%) stddev-sans-first:61996.81 05:48:49 INFO - PROCESS | 27650 | Values: 324.5 332.6 336.2 336.7 337.6 14602.3 15108.0 15661.8 15773.9 15808.8 14376.5 14736.9 14981.3 15822.1 15832.9 4950.7 5149.1 5150.4 5151.8 5157.5 4933.3 5025.3 5049.2 5078.8 5109.1 5039.6 5042.7 5043.5 5043.8 5053.8 4858.7 5006.1 5022.5 5025.4 5065.9 4477.9 4488.6 4492.1 4508.8 4512.0 17966.8 18487.7 18707.0 18730.7 18741.7 1781.8 1857.2 1896.3 2188.2 2384.1 12007.2 12100.0 12138.3 12183.7 12288.1 1724.7 1758.4 1764.0 1793.0 1851.4 53737.5 55624.0 57074.0 57153.4 57689.0 8929.5 8981.4 9106.2 9127.6 9255.8 11666.4 11740.6 11755.0 11766.1 11770.9 7050.2 7098.2 7118.8 7242.6 7250.2 7106.4 7143.8 7147.7 7195.6 7243.9 5461.4 5573.9 5595.6 5596.6 5671.6 1612.8 1650.6 1651.2 1662.7 1662.9 787.2 829.3 872.9 927.8 951.9 15230.7 15688.5 15736.8 15803.1 15848.0 819.2 885.7 910.4 947.6 956.5 8030.2 8124.4 8257.5 8258.8 8367.1 368261.0 377054.0 377629.0 381435.0 383822.0 44427.6 54266.7 58590.7 63429.0 67021.0 863.9 946.2 946.3 987.1 988.1 11424.7 13564.4 14257.0 14335.7 14378.9 31721.4 33499.3 33711.2 34093.7 34127.3 43672.0 46527.3 46900.8 46909.0 47068.0 6918.4 6960.3 6988.5 7023.4 7054.9 7969.1 10367.4 10599.8 10694.5 10763.2 9253.9 9323.8 9429.9 9492.3 9903.7 9503.2 9521.3 9576.7 9650.6 9659.7 8881.9 9082.1 9338.1 9492.6 9612.2 6970.0 7015.9 7116.4 7123.8 7180.7 7644.8 9019.5 9044.4 9077.4 9175.6 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - PROCESS | 27650 | [#3] mootools.html Cycles:180 Average:5185.55 Median:6082.80 stddev:2774.98 (45.6%) stddev-sans-first:2767.10 05:48:49 INFO - PROCESS | 27650 | Values: 1262.3 1412.0 1431.0 1602.7 1809.8 7202.0 7294.7 7331.7 7336.5 7337.3 7185.9 7374.6 7383.5 7390.6 7395.7 1731.3 2108.1 2110.2 2132.2 2178.3 2175.2 2187.2 2187.4 2189.6 2191.7 2056.9 2079.2 2080.4 2081.7 2086.2 2054.0 2054.1 2068.1 2155.8 2174.7 2130.7 2161.8 2166.7 2173.4 2178.1 7538.3 7597.8 7615.7 7616.1 7618.2 4241.3 4334.8 4337.1 4356.8 4359.6 2736.1 2805.0 2862.5 2867.8 2898.7 879.9 883.4 892.2 912.4 917.7 10588.7 10655.2 10663.3 10667.6 10686.4 3943.2 4064.7 4103.9 4109.3 4158.5 8795.3 8829.5 8844.4 8865.0 8878.1 3879.5 4420.5 4420.8 4427.9 4430.2 3913.1 3986.0 3986.4 4002.0 4010.1 3398.4 3441.4 3490.6 3509.7 3521.2 1105.4 1107.9 1116.2 1118.7 1119.8 1171.6 1173.1 1184.9 1190.5 1198.8 7098.7 7142.7 7180.2 7193.5 7206.5 436.1 451.1 451.4 451.4 452.4 5375.2 5402.0 5404.1 5411.8 5429.6 8559.2 8712.5 8869.1 8888.6 8908.7 8765.1 8813.8 8884.3 8892.7 8892.9 6803.1 6818.5 6959.5 6960.8 7002.2 6913.1 6926.3 6975.5 6979.4 6995.1 8008.0 8263.2 8296.3 8355.4 8478.8 8386.4 8697.8 8711.3 8717.3 8786.4 6434.6 6495.0 6609.0 6634.6 6636.3 7224.6 7238.4 7281.5 7281.7 7321.2 6303.1 6426.4 6477.4 6542.8 6610.0 6054.9 6095.7 6222.5 6240.4 6350.6 6453.7 6486.5 6493.4 6521.8 6538.7 5919.1 5976.9 6021.4 6032.5 6069.9 6146.5 6193.0 6213.8 6222.7 6227.8 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - PROCESS | 27650 | [#4] prototype.html Cycles:180 Average:4527.98 Median:5250.99 stddev:1344.04 (25.6%) stddev-sans-first:1309.80 05:48:49 INFO - PROCESS | 27650 | Values: 299.8 303.8 304.5 305.9 308.6 5188.1 5232.2 5245.5 5357.1 5370.0 5161.8 5176.0 5230.6 5256.5 5267.1 3828.5 3877.4 4026.0 4055.2 4068.0 4029.0 4029.1 4035.5 4037.9 4043.0 3970.1 3972.7 3979.8 3982.8 3987.3 3810.9 3881.0 3964.8 3991.1 4006.9 3457.4 3459.1 3468.2 3468.3 3471.9 5016.4 5017.9 5034.0 5040.7 5041.7 4560.2 4566.8 4568.2 4571.2 4578.0 5457.7 5468.5 5470.2 5473.9 5482.4 3776.6 3777.3 3777.9 3778.3 3784.7 5612.7 5664.9 5689.3 5752.0 5755.7 3835.9 3845.3 3855.1 3870.0 3872.5 3911.6 3916.0 3921.6 3923.8 3926.8 4525.7 4529.8 4535.9 4536.2 4550.5 5485.7 5492.8 5493.5 5494.3 5496.8 1365.2 1393.1 1395.1 1396.9 1397.2 858.5 899.4 920.5 954.1 954.2 4720.2 4806.9 4808.2 4810.8 4813.6 5621.9 5629.5 5631.7 5636.9 5637.3 4837.9 4842.6 4843.0 4849.1 4859.6 3007.9 3039.2 3051.0 3058.0 3065.7 5350.7 5358.1 5366.2 5374.8 5382.4 5663.0 5848.1 5857.6 5878.2 5880.0 5346.7 5372.4 5373.7 5377.6 5380.0 5704.8 5708.4 5708.9 5714.3 5715.8 5584.6 5584.7 5594.2 5601.6 5604.9 5362.5 5369.6 5370.5 5372.9 5377.9 3755.7 3874.2 3877.8 3886.6 3895.7 5686.1 5689.9 5734.0 5746.7 5749.6 5443.9 5456.5 5459.6 5468.6 5470.3 5452.8 5455.7 5457.8 5460.5 5463.8 5351.7 5355.0 5363.6 5366.9 5368.0 5346.1 5494.1 5504.5 5513.4 5514.3 5271.2 5287.7 5290.0 5292.2 5296.2 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - PROCESS | 27650 | [#5] yui.html Cycles:180 Average:11995.23 Median:39254.11 stddev:12913.56 (32.9%) stddev-sans-first:12921.70 05:48:49 INFO - PROCESS | 27650 | Values: 653.8 699.0 731.5 739.2 757.9 11777.6 11890.0 11894.0 11899.3 11904.9 11781.2 11850.5 13523.3 13753.1 13756.8 800.6 818.5 819.1 819.1 819.6 625.6 807.4 829.1 832.1 833.1 862.7 864.4 864.7 866.0 866.1 647.6 862.3 862.5 863.0 863.0 623.9 637.9 638.6 638.9 639.3 12266.5 12325.0 12350.1 12354.0 12354.1 11171.1 11787.3 11804.6 11917.6 11993.5 9543.9 9582.9 9708.3 9760.2 9880.7 3268.1 3291.9 3299.5 3351.3 3388.5 42570.4 42917.8 42941.8 42947.4 42994.1 9278.6 9428.4 9462.2 9577.1 9613.1 16498.8 16552.8 16600.7 16634.3 16657.8 6430.0 6486.7 6507.8 6590.7 6610.7 3570.1 3570.9 3601.0 3619.2 3624.5 2868.9 2869.0 2898.9 2904.8 2905.8 492.6 503.3 513.1 513.2 519.1 439.9 600.7 602.8 618.0 618.4 7493.1 7591.8 7880.3 8109.8 8259.4 458.1 558.9 601.1 603.4 619.6 3567.8 3677.7 3687.8 3807.2 3844.2 46632.8 46879.3 46991.5 47097.8 47105.3 37982.6 38153.6 38269.8 38372.8 38457.8 35869.8 35925.5 36496.0 37386.8 37465.8 7967.9 8064.0 8197.5 8202.8 8405.4 29515.4 29595.0 30132.8 30247.0 30774.5 33615.2 33768.3 37080.3 39197.6 39310.6 10559.6 10575.2 10716.3 10722.7 11361.4 11074.8 11083.8 11305.7 11441.2 11653.5 9686.5 10022.9 10090.2 10626.4 10667.3 10829.9 10998.5 11085.2 11152.4 11616.9 10327.7 10489.7 10508.1 10726.6 10752.2 9738.3 9753.9 10033.7 10118.4 10209.2 9019.5 9447.0 9601.8 9723.8 9728.3 05:48:49 INFO - PROCESS | 27650 | -------- Summary: end -------- 05:48:49 INFO - PROCESS | 27650 | 05:48:49 INFO - TEST-INFO | 27650: exit 0 05:48:49 INFO - TEST-OK | dromaeo_css | took 1117583ms 05:48:49 INFO - TEST-START | kraken 05:48:49 INFO - operating with platform_type : linux_ 05:48:49 INFO - Initialising browser for kraken test... 05:48:49 INFO - TEST-INFO | started process 27828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4vwfHp/profile http://localhost:32943/getInfo.html) 05:48:54 INFO - PROCESS | 27828 | __metrics Screen width/height:1600/1200 05:48:54 INFO - PROCESS | 27828 | colorDepth:24 05:48:54 INFO - PROCESS | 27828 | Browser inner width/height: 1024/697 05:48:54 INFO - PROCESS | 27828 | __metrics 05:48:55 ERROR - PROCESS | 27828 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:48:56 INFO - TEST-INFO | 27828: exit 0 05:48:56 INFO - Browser initialized. 05:48:56 INFO - Running cycle 1/1 for kraken test... 05:48:56 INFO - TEST-INFO | started process 27910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4vwfHp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:08 INFO - PROCESS | 27910 | RSS: Main: 154013696 05:49:08 INFO - PROCESS | 27910 | 05:49:11 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32943/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:11 INFO - PROCESS | 27910 | RSS: Main: 195010560 05:49:11 INFO - PROCESS | 27910 | 05:49:14 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32943/tests/kraken/driver.html?testName=audio-dft) 05:49:15 INFO - PROCESS | 27910 | RSS: Main: 184197120 05:49:15 INFO - PROCESS | 27910 | 05:49:18 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32943/tests/kraken/driver.html?testName=audio-fft) 05:49:18 INFO - PROCESS | 27910 | RSS: Main: 172347392 05:49:18 INFO - PROCESS | 27910 | 05:49:20 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32943/tests/kraken/driver.html?testName=audio-oscillator) 05:49:21 INFO - PROCESS | 27910 | RSS: Main: 173539328 05:49:21 INFO - PROCESS | 27910 | 05:49:23 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:24 INFO - PROCESS | 27910 | RSS: Main: 175730688 05:49:24 INFO - PROCESS | 27910 | 05:49:27 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32943/tests/kraken/driver.html?testName=imaging-darkroom) 05:49:28 INFO - PROCESS | 27910 | RSS: Main: 175558656 05:49:28 INFO - PROCESS | 27910 | 05:49:31 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32943/tests/kraken/driver.html?testName=imaging-desaturate) 05:49:32 INFO - PROCESS | 27910 | RSS: Main: 174448640 05:49:32 INFO - PROCESS | 27910 | 05:49:35 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32943/tests/kraken/driver.html?testName=json-parse-financial) 05:49:35 INFO - PROCESS | 27910 | RSS: Main: 175783936 05:49:35 INFO - PROCESS | 27910 | 05:49:37 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:49:38 INFO - PROCESS | 27910 | RSS: Main: 184455168 05:49:38 INFO - PROCESS | 27910 | 05:49:40 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:49:40 INFO - PROCESS | 27910 | RSS: Main: 184360960 05:49:40 INFO - PROCESS | 27910 | 05:49:42 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:49:43 INFO - PROCESS | 27910 | RSS: Main: 193060864 05:49:43 INFO - PROCESS | 27910 | 05:49:45 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:46 INFO - PROCESS | 27910 | RSS: Main: 196841472 05:49:46 INFO - PROCESS | 27910 | 05:49:49 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:49:49 INFO - PROCESS | 27910 | RSS: Main: 195964928 05:49:49 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32943/tests/kraken/driver.html?testName=ai-astar) 05:49:51 INFO - PROCESS | 27910 | RSS: Main: 256602112 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | __start_tp_report 05:49:51 INFO - PROCESS | 27910 | _x_x_mozilla_page_load 05:49:51 INFO - PROCESS | 27910 | _x_x_mozilla_page_load_details 05:49:51 INFO - PROCESS | 27910 | |i|pagename|runs| 05:49:51 INFO - PROCESS | 27910 | |0;ai-astar;112;113;109;112;114;114;105;113;113;114 05:49:51 INFO - PROCESS | 27910 | |1;audio-beat-detection;155;132;160;166;134;157;161;140;188;138 05:49:51 INFO - PROCESS | 27910 | |2;audio-dft;161;162;164;160;162;160;163;161;162;161 05:49:51 INFO - PROCESS | 27910 | |3;audio-fft;74;74;103;92;73;74;74;112;91;74 05:49:51 INFO - PROCESS | 27910 | |4;audio-oscillator;94;93;140;94;94;95;138;95;94;133 05:49:51 INFO - PROCESS | 27910 | |5;imaging-gaussian-blur;117;118;116;117;117;117;117;117;117;117 05:49:51 INFO - PROCESS | 27910 | |6;imaging-darkroom;147;146;147;148;149;146;146;148;147;147 05:49:51 INFO - PROCESS | 27910 | |7;imaging-desaturate;95;95;96;95;96;96;96;96;96;95 05:49:51 INFO - PROCESS | 27910 | |8;json-parse-financial;66;66;65;66;65;66;67;74;63;64 05:49:51 INFO - PROCESS | 27910 | |9;json-stringify-tinderbox;70;70;70;70;70;71;71;72;76;71 05:49:51 INFO - PROCESS | 27910 | |10;stanford-crypto-aes;83;87;85;84;93;84;84;84;84;83 05:49:51 INFO - PROCESS | 27910 | |11;stanford-crypto-ccm;122;128;121;121;121;119;119;119;119;122 05:49:51 INFO - PROCESS | 27910 | |12;stanford-crypto-pbkdf2;151;140;151;150;149;138;148;147;151;148 05:49:51 INFO - PROCESS | 27910 | |13;stanford-crypto-sha256-iterative;70;69;71;70;69;69;70;70;69;69 05:49:51 INFO - PROCESS | 27910 | __end_tp_report 05:49:51 INFO - PROCESS | 27910 | __start_cc_report 05:49:51 INFO - PROCESS | 27910 | _x_x_mozilla_cycle_collect,1159 05:49:51 INFO - PROCESS | 27910 | __end_cc_report 05:49:51 INFO - PROCESS | 27910 | __startTimestamp1457617791799__endTimestamp 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | ------- Summary: start ------- 05:49:51 INFO - PROCESS | 27910 | Number of tests: 14 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.85 (2.5%) stddev-sans-first:3.02 05:49:51 INFO - PROCESS | 27910 | Values: 112.0 113.0 109.0 112.0 114.0 114.0 105.0 113.0 113.0 114.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:158.50 stddev:17.39 (11.0%) stddev-sans-first:18.44 05:49:51 INFO - PROCESS | 27910 | Values: 155.0 132.0 160.0 166.0 134.0 157.0 161.0 140.0 188.0 138.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 05:49:51 INFO - PROCESS | 27910 | Values: 161.0 162.0 164.0 160.0 162.0 160.0 163.0 161.0 162.0 161.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#3] audio-fft Cycles:10 Average:84.10 Median:74.00 stddev:14.45 (19.5%) stddev-sans-first:14.86 05:49:51 INFO - PROCESS | 27910 | Values: 74.0 74.0 103.0 92.0 73.0 74.0 74.0 112.0 91.0 74.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:94.00 stddev:20.78 (22.1%) stddev-sans-first:21.50 05:49:51 INFO - PROCESS | 27910 | Values: 94.0 93.0 140.0 94.0 94.0 95.0 138.0 95.0 94.0 133.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:49:51 INFO - PROCESS | 27910 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 05:49:51 INFO - PROCESS | 27910 | Values: 147.0 146.0 147.0 148.0 149.0 146.0 146.0 148.0 147.0 147.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:49:51 INFO - PROCESS | 27910 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:2.97 (4.5%) stddev-sans-first:3.15 05:49:51 INFO - PROCESS | 27910 | Values: 66.0 66.0 65.0 66.0 65.0 66.0 67.0 74.0 63.0 64.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:1.85 (2.6%) stddev-sans-first:1.92 05:49:51 INFO - PROCESS | 27910 | Values: 70.0 70.0 70.0 70.0 70.0 71.0 71.0 72.0 76.0 71.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:3.00 (3.6%) stddev-sans-first:3.08 05:49:51 INFO - PROCESS | 27910 | Values: 83.0 87.0 85.0 84.0 93.0 84.0 84.0 84.0 84.0 83.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:121.00 stddev:2.73 (2.3%) stddev-sans-first:2.87 05:49:51 INFO - PROCESS | 27910 | Values: 122.0 128.0 121.0 121.0 121.0 119.0 119.0 119.0 119.0 122.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:149.50 stddev:4.62 (3.1%) stddev-sans-first:4.70 05:49:51 INFO - PROCESS | 27910 | Values: 151.0 140.0 151.0 150.0 149.0 138.0 148.0 147.0 151.0 148.0 05:49:51 INFO - PROCESS | 27910 | 05:49:51 INFO - PROCESS | 27910 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 05:49:51 INFO - PROCESS | 27910 | Values: 70.0 69.0 71.0 70.0 69.0 69.0 70.0 70.0 69.0 69.0 05:49:51 INFO - PROCESS | 27910 | -------- Summary: end -------- 05:49:51 INFO - PROCESS | 27910 | 05:49:52 INFO - TEST-INFO | 27910: exit 0 05:49:52 INFO - TEST-OK | kraken | took 62974ms 05:49:52 INFO - SUITE-END | took 1180s 05:49:52 INFO - Completed test suite (00:19:40) 05:49:52 INFO - javascript benchmark 05:49:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2571.2660766490726, 2638.089858998646, 2654.8938042478303, 2668.7197844226357, 2687.046098634984, 4402.3836662867225, 4456.910861782762, 4474.686771925963, 4498.730076195427, 4539.614132798716, 4433.667474939376, 4486.237339652259, 4499.280115181572, 4512.323151527265, 4559.794809233585, 4138.13099249158, 4169.937450938246, 4250.192463431938, 4291.8497852575165, 4308.82764689412, 4059.106996460774, 4215.156968606291, 4240.151969606076, 4260.446142001535, 4272.188284225987, 4112.198121366319, 4147.191297696951, 4147.958520414818, 4189.476315460567, 4197.034682023152, 4136.689748268862, 4143.875683729493, 4167.187398457302, 4179.97910010448, 4182.309918863384, 4073.429719839225, 4141.813618387149, 4151.771652559108, 4153.501579810442, 4198.0, 4367.956320436787, 4389.495208051083, 4410.955890441087, 4443.4445694288215, 4453.465584129893, 4791.401074865642, 4805.014971930746, 4812.518748125194, 4820.517948205152, 4820.879478013043, 4752.5485078917445, 4767.785449654774, 4833.250846118857, 4855.562999330042, 4886.242632391985, 4540.0011997360525, 4540.273556230987, 4567.771611419482, 4568.862934111982, 4585.037142200175, 4973.701577905337, 4974.502549745069, 4976.278439626306, 4977.8257760978195, 4978.253262010728, 4656.208444564364, 4706.858794236178, 4782.593479554207, 4787.736674482937, 4822.300766388854, 4779.545943135466, 4800.855974320776, 4809.374781278411, 4830.227163653799, 4837.540433658867, 4735.526447355306, 4749.430068391815, 4752.097101550694, 4754.595859351924, 4791.185498465269, 4569.817207311737, 4737.313089601988, 4753.904921901542, 4814.037192561502, 4826.831060912851, 4023.8390464381096, 4032.737872038308, 4040.393940908887, 4059.7564146151326, 4083.387491876183, 3578.355895938756, 3583.7849729016343, 3589.4615807628543, 3591.3894637911617, 3612.8193590320902, 4022.537408198095, 4094.897627559335, 4124.587541245912, 4182.079942412664, 4183.393407955829, 4776.474587795409, 4789.066132104276, 4809.615230781529, 4810.134175848311, 4845.927311090337, 4163.333866581393, 4170.270202714512, 4171.520275168395, 4204.873853784391, 4206.390073439396, 4187.874363769091, 4305.117450922616, 4322.827086916551, 4335.566443355639, 4357.9128417431475, 4486.730796152241, 4497.730136191839, 4506.143832671782, 4512.526184750685, 4542.545745425497, 4701.7414042228, 4741.099191153669, 4742.336072949721, 4746.833860814855, 4783.354247176726, 4520.18636645407, 4559.475660299108, 4561.224591819465, 4585.885352866205, 4596.747178905192, 4708.419444693972, 4710.64670149747, 4712.128256272601, 4713.340132381538, 4735.242361222188, 4710.858674239778, 4764.142454358249, 4767.833125840579, 4774.474807771212, 4813.5186481352985, 4648.2562789953445, 4662.347271381941, 4676.836310729108, 4677.251639737626, 4719.339292498984, 4668.836590719445, 4670.369500117441, 4671.135839869635, 4707.929381059355, 4721.669483136147, 4439.178751930903, 4471.06107717383, 4577.633789296915, 4592.402987611589, 4603.194440972749, 4643.0, 4655.20861453547, 4659.021605462891, 4691.577758001797, 4703.576678098988, 4517.232070547949, 4519.096180763795, 4519.502854685916, 4557.658175636774, 4558.794854231502], "unit": "score", "name": "dojo.html", "value": 4417.178880269921}, {"lowerIsBetter": false, "replicates": [492.9753512324383, 502.4724039758253, 553.3553410277027, 553.5626854784721, 564.2664536103067, 25269.74730252697, 25951.221463356083, 33907.32185356294, 34481.482777758356, 34527.82736086316, 37341.43987840185, 37811.432828507524, 38001.429978550346, 38006.4299035514, 38089.0, 7630.0843898731955, 7794.142644309121, 7794.259545343211, 7800.297973182441, 7809.140994490602, 7585.0, 7649.579273139975, 7699.960505331793, 7702.26828451299, 7706.6146692665425, 7693.961530192341, 7744.496607720508, 7922.049354077519, 7929.960350198241, 7955.72154974576, 7858.567778772165, 7903.762887113338, 7925.0489941207425, 7929.682812687543, 7931.484453510532, 7898.447108702393, 8027.197280271985, 8027.678892844279, 8029.116797152308, 8033.919660803375, 37923.241535169414, 38369.61630383688, 38370.808145959374, 38426.231475370616, 38472.422913656315, 2889.8699558519916, 2924.7075292470795, 2937.3097322129283, 2979.002034318506, 3019.4866872631706, 28061.859690701414, 28310.575341369895, 28388.290292742848, 28570.857145714348, 29311.41377172466, 3433.8626454941773, 3477.061193477772, 3488.459288810213, 3510.3514803730045, 3526.4710293455933, 210085.0, 210225.99999999846, 210239.0, 210804.0, 210984.0, 54203.18695219575, 54228.45771542313, 54571.0, 54620.72689636606, 54656.0, 57320.42679573235, 57495.42504574984, 57501.0, 62252.0, 63381.68309158517, 14289.428422863177, 14529.491467798576, 14539.709205815825, 14546.127232366092, 14551.854481455262, 10997.890021099687, 11053.0, 11083.224174307883, 11094.55621775136, 11099.667009989713, 19330.702966395405, 19592.314269000515, 20131.19475221004, 20164.092615832324, 20197.899010504854, 7925.564093974886, 8077.869098326239, 8105.1489593593005, 8134.633941472648, 8174.877376839352, 801.5711594297023, 810.491528718615, 845.2815107158989, 943.0, 1006.6074231049896, 24237.151699690425, 25612.231633051037, 26137.869310653707, 26514.0, 26715.465690686466, 915.8351496730652, 943.1228957069991, 955.245356168633, 988.4958671077802, 1025.4308858583559, 13671.316434178252, 13899.166050036827, 13970.790438143233, 13993.930030349784, 14038.438462461592, 301443.0, 305432.0, 308451.0, 308627.0, 309017.0, 48982.0, 50278.24582631263, 50416.24375634368, 50690.493095069316, 50769.238461423105, 1126.971825704364, 1193.254216114928, 1210.727586293077, 1230.6000549821345, 1234.5925844471483, 26638.600420994087, 27690.0, 28740.137795866158, 30011.249718757204, 30691.2327191822, 39855.40216896807, 40473.79763101166, 41173.588264116974, 41183.176336472505, 41227.79386103051, 230846.0, 238285.0, 238471.0, 238485.0, 238647.0, 32004.839975799972, 39703.0, 39911.40132897951, 40502.79748601238, 40878.38682419706, 38367.808160959015, 39294.803525983334, 39837.40243896402, 39881.401778973915, 42401.36397953972, 33243.335133296714, 33597.496037558965, 33652.663473364955, 34222.31555368929, 34503.4824477638, 35943.0, 36648.45027324539, 36770.0, 37099.629003710696, 37136.0, 35969.64030359663, 36232.818835906706, 36368.27263454769, 36597.268054638225, 36698.082547936516, 32122.839385802923, 32600.0, 32724.836375818923, 32792.34415311728, 32907.341853162325, 25521.361965951, 25565.23304300874, 25641.871790640926, 25678.614820778075, 25822.61266081048], "unit": "score", "name": "ext.html", "value": 17251.550036700395}, {"lowerIsBetter": false, "replicates": [324.508369819723, 332.6067810453497, 336.1763678986483, 336.74912190418144, 337.5898283585443, 14602.342894569756, 15108.0, 15661.843381566181, 15773.921130394332, 15808.762868556982, 14376.49682261121, 14736.852631473683, 14981.325840337184, 15822.129782861937, 15832.920835395837, 4950.727709975941, 5149.0731668299695, 5150.4334523202415, 5151.845444636649, 5157.5358217760395, 4933.260010998343, 5025.271335656327, 5049.192129259319, 5078.7968481260705, 5109.080365534202, 5039.596832253429, 5042.747862606873, 5043.470435604264, 5043.84868453947, 5053.797848086072, 4858.659893807418, 5006.123928312531, 5022.547970682638, 5025.3718285214345, 5065.898682026339, 4477.888052798674, 4488.5960263576435, 4492.101579684044, 4508.819647214107, 4512.029913568598, 17966.820331796775, 18487.722684159748, 18707.0, 18730.719039214422, 18741.7188742169, 1781.7950935642436, 1857.2385322017908, 1896.2888916656254, 2188.1684959715367, 2384.0821283805685, 12007.159498835084, 12100.0, 12138.271703697717, 12183.695407614792, 12288.139830211889, 1724.7412888066765, 1758.4285107340038, 1763.9735403968823, 1792.9551761205944, 1851.426057922035, 53737.462625373635, 55624.0, 57074.0, 57153.428465715224, 57689.0, 8929.464232145961, 8981.371304008657, 9106.18044375996, 9127.634894604274, 9255.768605784775, 11666.416679166177, 11740.589079382351, 11755.0, 11766.117541184445, 11770.88229117715, 7050.189228238715, 7098.219195888448, 7118.822029449305, 7242.6378681065735, 7250.16623088341, 7106.395956343666, 7143.785686429415, 7147.749828755968, 7195.640217989079, 7243.927560724431, 5461.399246082928, 5573.944260557424, 5595.608307418523, 5596.58025648078, 5671.638806686366, 1612.8387161284013, 1650.5708515785982, 1651.174412793603, 1662.684090022916, 1662.9002259864446, 787.2009909941414, 829.2660995019452, 872.8777971084053, 927.8376284150247, 951.9100629779002, 15230.695386092217, 15688.450904218298, 15736.763948540782, 15803.130827804582, 15848.0, 819.2012787532227, 885.6900084970209, 910.4036855859423, 947.5688561704408, 956.4739393333639, 8030.196980301923, 8124.390670699603, 8257.504549727035, 8258.793530161674, 8367.121452247547, 368261.0, 377054.0, 377629.0, 381435.0, 383822.0, 44427.55572444234, 54266.728666356415, 58590.707046465344, 63429.0, 67021.0, 863.9438436501607, 946.2477330522252, 946.3328353510758, 987.1214618989105, 988.1304452082122, 11424.657260282205, 13564.38960246811, 14257.0, 14335.713285734435, 14378.856211437751, 31721.365572687955, 33499.33001339911, 33711.157221068686, 34093.659063409046, 34127.31745365029, 43672.0, 46527.30209046935, 46900.7654961723, 46909.0, 47068.0, 6918.377346038881, 6960.338767817049, 6988.545744526589, 7023.3678968891, 7054.929450705633, 7969.083555391204, 10367.429791361548, 10599.788004239717, 10694.465276735977, 10763.192760543147, 9253.86119208199, 9323.813523729623, 9429.905700942903, 9492.335536512377, 9903.702888913343, 9503.23974082058, 9521.333506654468, 9576.664816731382, 9650.565724542272, 9659.71020869375, 8881.866771998555, 9082.137196966278, 9338.066193380608, 9492.572834222614, 9612.231021518122, 6970.0, 7015.859682806214, 7116.359527642537, 7123.82190445243, 7180.748673796392, 7644.847103058019, 9019.549022548716, 9044.41211321262, 9077.409968352036, 9175.587098580714], "unit": "score", "name": "jquery.html", "value": 7706.9724449861}, {"lowerIsBetter": false, "replicates": [1262.3246563088737, 1412.0398129272094, 1430.9713805723886, 1602.679464107178, 1809.7828260608721, 7202.0, 7294.708211671526, 7331.7433889813865, 7336.486445948779, 7337.339639432456, 7185.89221161683, 7374.631268436584, 7383.48315617907, 7390.556566606007, 7395.70417183312, 1731.3334366269014, 2108.11459187141, 2110.2403134871433, 2132.1577976699195, 2178.2593918067855, 2175.1516908405733, 2187.1798075721604, 2187.4093994621444, 2189.5730332585154, 2191.671249312608, 2056.856020078595, 2079.189116244666, 2080.4278823323557, 2081.6669332906736, 2086.1863873089505, 2053.9897300513476, 2054.085931760367, 2068.11071239367, 2155.7844215578475, 2174.6737989301573, 2130.7017017617545, 2161.848670593059, 2166.7183266175452, 2173.4240426287047, 2178.063432723928, 7538.321551060376, 7597.848043039108, 7615.7334493292465, 7616.0860696716745, 7618.238176182393, 4241.300185469394, 4334.783260836977, 4337.110892267077, 4356.803943822536, 4359.585839345257, 2736.1107640016876, 2804.9859750701116, 2862.4561333346805, 2867.813592116506, 2898.68114507404, 879.8636211387245, 883.4434306387, 892.2237653241722, 912.3522299167532, 917.7200953709116, 10588.735281617945, 10655.200859935536, 10663.253572249945, 10667.626633067883, 10686.358818470839, 3943.152222272225, 4064.7154699171365, 4103.9179216416105, 4109.2808758467145, 4158.480189976253, 8795.296376289882, 8829.470231786114, 8844.380893337533, 8865.024847266795, 8878.067802880734, 3879.4568760373572, 4420.513743488214, 4420.756858372756, 4427.867163985085, 4430.224710675619, 3913.1195481016543, 3986.043349596076, 3986.421968814506, 4002.0, 4010.137820368635, 3398.4392575225306, 3441.397755392796, 3490.6334834842482, 3509.6841284284537, 3521.207728261121, 1105.3533682795655, 1107.9446027698743, 1116.1963386361806, 1118.6532175025768, 1119.8040342939953, 1171.5614670940815, 1173.0908545876844, 1184.8755880632582, 1190.4642910690052, 1198.8081906894854, 7098.68055937484, 7142.714291428389, 7180.210176880539, 7193.460490463236, 7206.531575447579, 436.147331966012, 451.11131071788526, 451.37033837796747, 451.4199253958713, 452.4457539514069, 5375.166849138312, 5401.972990135024, 5404.081306177959, 5411.783528658888, 5429.56563474921, 8559.186877246651, 8712.520811355436, 8869.11308869108, 8888.60001299943, 8908.73273801787, 8765.123487651312, 8813.823723525493, 8884.333674974403, 8892.73321800347, 8892.911070889208, 6803.081583986197, 6818.488613353919, 6959.478039146983, 6960.79117626472, 7002.1947476040905, 6913.1358580177475, 6926.272741362286, 6975.546589471668, 6979.441644668516, 6995.125609298838, 8008.0, 8263.173682631688, 8296.253337199681, 8355.415120941476, 8478.83042339162, 8386.412951093365, 8697.826043478968, 8711.25954293892, 8717.346199035224, 8786.384953053224, 6434.613923164625, 6495.0, 6609.0, 6634.568753031231, 6636.303188165173, 7224.566526008456, 7238.420926325776, 7281.490295679251, 7281.708731650887, 7321.158066822383, 6303.086052522267, 6426.42162205385, 6477.352264773485, 6542.8364290893105, 6609.966950165219, 6054.878902422015, 6095.664738439428, 6222.471089957405, 6240.4071613196675, 6350.555461117678, 6453.741850325934, 6486.481081513373, 6493.415592596689, 6521.836954076186, 6538.738450461929, 5919.141724449844, 5976.8804623908145, 6021.397860214119, 6032.487238584769, 6069.939300607114, 6146.477549408351, 6193.0, 6213.813585592439, 6222.688865556795, 6227.782027629011], "unit": "score", "name": "mootools.html", "value": 4155.296442559341}, {"lowerIsBetter": false, "replicates": [299.8305957134219, 303.80556443875923, 304.4732612580236, 305.89293747188503, 308.62502059997115, 5188.0920838853235, 5232.16285394337, 5245.501677340656, 5357.142857142858, 5370.0, 5161.819336323229, 5175.974120129404, 5230.555402790757, 5256.474352564742, 5267.051930652481, 3828.464015037897, 3877.4377715231276, 4026.0136266614722, 4055.209234199325, 4067.959320406788, 4028.9597104028876, 4029.0531725044593, 4035.4552135461777, 4037.9192416151805, 4043.0498832774274, 3970.067034246964, 3972.682185425159, 3979.820908059144, 3982.8406863725418, 3987.262356464049, 3810.8856734298015, 3881.0, 3964.8215830287704, 3991.102002049545, 4006.8998275043064, 3457.429524128516, 3459.08334291413, 3468.1849765305133, 3468.3410152071024, 3471.878484253039, 5016.3980322361185, 5017.874553136201, 5034.043531728959, 5040.697558146523, 5041.747912604355, 4560.201964656172, 4566.794494247767, 4568.2462393705, 4571.154336447735, 4578.0, 5457.672539647594, 5468.507834294893, 5470.152126420411, 5473.917891231635, 5482.396936337, 3776.622337766229, 3777.301199278142, 3777.9055523611855, 3778.301014312361, 3784.6593806557266, 5612.663240205601, 5664.915026274609, 5689.260396148516, 5751.971240143815, 5755.683437410982, 3835.9424608630893, 3845.288621605012, 3855.094052897567, 3869.9744567689586, 3872.4772155759174, 3911.5501717302304, 3916.0, 3921.5882332355263, 3923.843046278117, 3926.764394136361, 4525.683202175882, 4529.818807247673, 4535.931961020588, 4536.206163921301, 4550.453945526492, 5485.725713714299, 5492.80775172867, 5493.533049690741, 5494.2857428534835, 5496.835094947158, 1365.1604263377951, 1393.0736060519844, 1395.0931894268806, 1396.860313968595, 1397.2035939514583, 858.4505916213628, 899.3929097858919, 920.5489310237936, 954.1222075690381, 954.1508057828538, 4720.173969555314, 4806.903861922742, 4808.230683090758, 4810.759462026885, 4813.566778989908, 5621.8594535136945, 5629.493345598834, 5631.6902570359025, 5636.887262254732, 5637.267155269788, 4837.854864354075, 4842.58837998774, 4843.038569379407, 4849.127157111754, 4859.562639362474, 3007.9248018799267, 3039.1642298368124, 3051.023672424847, 3057.975578181334, 3065.662777094518, 5350.652207606493, 5358.062339090644, 5366.221897824794, 5374.785008599612, 5382.3541175059245, 5663.0, 5848.064309710426, 5857.619254748428, 5878.2358293421585, 5880.0, 5346.652467589594, 5372.435894231127, 5373.704446255337, 5377.596680248997, 5380.0, 5704.771809127755, 5708.372079071381, 5708.8572785679025, 5714.285714285715, 5715.828525144252, 5584.609077364546, 5584.720763961867, 5594.244776955059, 5601.579881508985, 5604.943950560605, 5362.463753624606, 5369.624126311121, 5370.516653501204, 5372.946270537244, 5377.865553361197, 3755.7370984030854, 3874.1670540833857, 3877.786721730332, 3886.6113388660906, 3895.6883449324555, 5686.118651609007, 5689.914651280317, 5734.0, 5746.655200687972, 5749.568782341257, 5443.863903402446, 5456.536194423518, 5459.563234941115, 5468.589855760913, 5470.288862447856, 5452.809151679672, 5455.727213639223, 5457.781688732565, 5460.508554229979, 5463.7814487420055, 5351.678899266057, 5355.0, 5363.597730170175, 5366.946330536801, 5368.033753924331, 5346.117890548016, 5494.066008778597, 5504.4770746778995, 5513.448655134454, 5514.310711161105, 5271.20931860224, 5287.735613219401, 5290.047791397586, 5292.20616907467, 5296.232046353334], "unit": "score", "name": "prototype.html", "value": 4096.167255956036}, {"lowerIsBetter": false, "replicates": [653.7875190563066, 698.9650517474125, 731.4989232375826, 739.2496615934826, 757.8673732096884, 11777.587784427547, 11889.989350905184, 11894.04847612191, 11899.286042837435, 11904.940475297622, 11781.23421977573, 11850.466728997195, 13523.256220907846, 13753.106048106865, 13756.793648095287, 800.5516910530092, 818.5211651184035, 819.0580832043169, 819.1480859905691, 819.6434550970317, 625.6277514878662, 807.4347956430522, 829.050736906242, 832.1054866019024, 833.0919297965216, 862.6549380247919, 864.4078806017866, 864.6671031652796, 865.9523726195057, 866.0603245478632, 647.5920170292685, 862.3316929379781, 862.525610913998, 862.9741107766746, 863.0420233540733, 623.9282482514524, 637.8692368064536, 638.5530128909735, 638.9488840892717, 639.2840019178503, 12266.509339626404, 12325.0, 12350.073744469111, 12354.0, 12354.135210535265, 11171.121220971972, 11787.292762434281, 11804.586839460664, 11917.582884599084, 11993.460294286691, 9543.904560954372, 9582.856257156149, 9708.271879609058, 9760.170385517169, 9880.654177103766, 3268.0686004488844, 3291.9341613167603, 3299.5050742388594, 3351.262722201112, 3388.457846744509, 42570.36144457835, 42917.78541107274, 42941.785291073655, 42947.35578966318, 42994.14011719779, 9278.628854845865, 9428.387154834914, 9462.195713364303, 9577.139213263725, 9613.086756758097, 16498.83501164997, 16552.75170872438, 16600.6679866402, 16634.25145868439, 16657.83342166563, 6429.9678501607195, 6486.67566621667, 6507.772227971998, 6590.703418346186, 6610.669466526654, 3570.143165640228, 3570.8571657133944, 3600.963990360063, 3619.2037751694584, 3624.474451204613, 2868.8995885144336, 2868.9713102868704, 2898.869550870216, 2904.8257104573795, 2905.7675385969073, 492.6428339453867, 503.3280570438433, 513.1225604216831, 513.1968469345462, 519.0605004940993, 439.8966242932908, 600.7446835095154, 602.8312072619674, 618.040859917334, 618.3630860213987, 7493.100827900578, 7591.810204744815, 7880.290773830383, 8109.797255068553, 8259.38054645904, 458.1455585333329, 558.8682917092838, 601.1223613524304, 603.3996173807002, 619.6344156947423, 3567.8037707926314, 3677.6506231907924, 3687.778733276012, 3807.238552289498, 3844.231153769257, 46632.7668361656, 46879.29681054787, 46991.530084698716, 47097.76451117722, 47105.293420598035, 37982.620173797906, 38153.61846381556, 38269.80865095712, 38372.808135959145, 38457.807710961264, 35869.8206508971, 35925.46111808325, 36495.99999999947, 37386.8130659345, 37465.81267093647, 7967.880481792662, 8063.959680201561, 8197.46716463428, 8202.753917382488, 8405.369597280107, 29515.409691805613, 29594.999999999138, 30132.84933575318, 30247.0, 30774.538381924736, 33615.15962100967, 33768.324633507684, 37080.25839483141, 39197.6080239194, 39310.60689393069, 10559.577616895238, 10575.206859485415, 10716.303440276357, 10722.73193170177, 11361.375124367909, 11074.778504430027, 11083.778324433628, 11305.660830175108, 11441.199116061796, 11653.533858645898, 9686.515674216402, 10022.899771002196, 10090.2432317575, 10626.415547144981, 10667.253292269466, 10829.891701082888, 10998.505067272152, 11085.22403431752, 11152.442377881236, 11616.88383116158, 10327.741806454898, 10489.685309440729, 10508.106810921157, 10726.570937162425, 10752.193585481276, 9738.269629777653, 9753.9024609753, 10033.749156271151, 10118.368440374301, 10209.234307426825, 9019.5039272838, 9446.95276523613, 9601.807963840545, 9723.756906077404, 9728.319017668695], "unit": "score", "name": "yui.html", "value": 5782.159768978088}], "name": "dromaeo_css", "value": 6218.164208918639}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 109.0, 112.0, 114.0, 114.0, 105.0, 113.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 160.0, 166.0, 134.0, 157.0, 161.0, 140.0, 188.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 153.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 164.0, 160.0, 162.0, 160.0, 163.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 103.0, 92.0, 73.0, 74.0, 74.0, 112.0, 91.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 140.0, 94.0, 94.0, 95.0, 138.0, 95.0, 94.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 148.0, 149.0, 146.0, 146.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 67.0, 74.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 71.0, 72.0, 76.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 85.0, 84.0, 93.0, 84.0, 84.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [122.0, 128.0, 121.0, 121.0, 121.0, 119.0, 119.0, 119.0, 119.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [151.0, 140.0, 151.0, 150.0, 149.0, 138.0, 148.0, 147.0, 151.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1537.7999999999997}]} 05:49:53 INFO - Return code: 0 05:49:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:49:53 ERROR - # TBPL SUCCESS # 05:49:53 INFO - Running post-action listener: _resource_record_post_action 05:49:53 INFO - Running post-run listener: _resource_record_post_run 05:49:54 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 20480; Write bytes: 287330304; Read time: 36; Write time: 213764 05:49:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1327104; Read time: 0; Write time: 76 05:49:54 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 20480; Write bytes: 286003200; Read time: 36; Write time: 213688 05:49:54 INFO - Running post-run listener: _upload_blobber_files 05:49:54 INFO - Blob upload gear active. 05:49:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:49:54 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:54 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:54 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:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:55 INFO - (blobuploader) - INFO - Done attempting. 05:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:49:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:56 INFO - (blobuploader) - INFO - Done attempting. 05:49:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:49:56 INFO - Return code: 0 05:49:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:49:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:49:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21f5d8becba792ae43db936087dd4320d8192da7193eedadc7987b4f89840607344139475af0984edd02c5723b2b5ff616898d2120ae5077acd4059650781234", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e391d628ebf24ff092fc326c076ab49a58957a22b2fca7fa7e918103beb5ed3ca798bc835ab1e55c754c6d8e7897132a189c3fc6c57c31b7304d1d520464a8ad"} 05:49:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:49:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:49:56 INFO - Contents: 05:49:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21f5d8becba792ae43db936087dd4320d8192da7193eedadc7987b4f89840607344139475af0984edd02c5723b2b5ff616898d2120ae5077acd4059650781234", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e391d628ebf24ff092fc326c076ab49a58957a22b2fca7fa7e918103beb5ed3ca798bc835ab1e55c754c6d8e7897132a189c3fc6c57c31b7304d1d520464a8ad"} 05:49:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:49:56 INFO - Copying logs to upload dir... 05:49:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:49:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.145281 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-03-10 05:49:56.229609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 05:49:56.232660) ========= 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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 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/21f5d8becba792ae43db936087dd4320d8192da7193eedadc7987b4f89840607344139475af0984edd02c5723b2b5ff616898d2120ae5077acd4059650781234", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e391d628ebf24ff092fc326c076ab49a58957a22b2fca7fa7e918103beb5ed3ca798bc835ab1e55c754c6d8e7897132a189c3fc6c57c31b7304d1d520464a8ad"} 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.011179 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/21f5d8becba792ae43db936087dd4320d8192da7193eedadc7987b4f89840607344139475af0984edd02c5723b2b5ff616898d2120ae5077acd4059650781234", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e391d628ebf24ff092fc326c076ab49a58957a22b2fca7fa7e918103beb5ed3ca798bc835ab1e55c754c6d8e7897132a189c3fc6c57c31b7304d1d520464a8ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 05:49:56.260233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:49:56.260602) ========= 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=eca2ab57546de7b41f256b19000001ef-1457616325.801473-685251409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 05:49:56.339935) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 05:49:56.343299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 05:49:56.343736) ========= ========= Total master_lag: 0.30 =========