builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1464887107.67 results: success (0) buildid: 20160602073025 builduid: 1b0cdb8a6e1a4ba782c27240840fc38c revision: 92e0c73391e71a400e2c6674bca5ca70804ab081 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.673061) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.673495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.673770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.688033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.688292) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 10:05:07-- 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% 46.6M=0s 2016-06-02 10:05:08 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.803991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.804279) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017463 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.853016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:07.853358) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 92e0c73391e71a400e2c6674bca5ca70804ab081 --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 92e0c73391e71a400e2c6674bca5ca70804ab081 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 10:05:08,112 truncating revision to first 12 chars 2016-06-02 10:05:08,112 Setting DEBUG logging. 2016-06-02 10:05:08,112 attempt 1/10 2016-06-02 10:05:08,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/92e0c73391e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 10:05:08,740 unpacking tar archive at: mozilla-central-92e0c73391e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.961750 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:08.828334) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:08.828668) ========= script_repo_revision: 92e0c73391e71a400e2c6674bca5ca70804ab081 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:08.829065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:08.829331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 10:05:08.837840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-02 10:05:08.838111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:09 INFO - MultiFileLogger online at 20160602 10:05:09 in /builds/slave/test 10:05:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:05:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:09 INFO - {'append_to_log': False, 10:05:09 INFO - 'base_work_dir': '/builds/slave/test', 10:05:09 INFO - 'blob_upload_branch': 'Firefox', 10:05:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:09 INFO - 'branch': 'Firefox', 10:05:09 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:09 INFO - 'config_files': ('talos/linux_config.py',), 10:05:09 INFO - 'default_actions': ('clobber', 10:05:09 INFO - 'read-buildbot-config', 10:05:09 INFO - 'download-and-extract', 10:05:09 INFO - 'populate-webroot', 10:05:09 INFO - 'create-virtualenv', 10:05:09 INFO - 'install', 10:05:09 INFO - 'run-tests'), 10:05:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:09 INFO - 'download_minidump_stackwalk': True, 10:05:09 INFO - 'download_symbols': 'ondemand', 10:05:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:09 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:09 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:09 INFO - 'installer_path': 'installer.exe', 10:05:09 INFO - 'log_level': 'info', 10:05:09 INFO - 'log_name': 'talos', 10:05:09 INFO - 'log_to_console': True, 10:05:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:09 INFO - 'opt_config_files': (), 10:05:09 INFO - 'pip_index': False, 10:05:09 INFO - 'sps_profile': False, 10:05:09 INFO - 'sps_profile_interval': 0, 10:05:09 INFO - 'suite': 'dromaeojs', 10:05:09 INFO - 'system_bits': '32', 10:05:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:09 INFO - 'title': 'talos-linux64-ix-018', 10:05:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:09 INFO - 'use_talos_json': True, 10:05:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:09 INFO - 'work_dir': 'build'} 10:05:09 INFO - ##### 10:05:09 INFO - ##### Running clobber step. 10:05:09 INFO - ##### 10:05:09 INFO - Running pre-action listener: _resource_record_pre_action 10:05:09 INFO - Running main action method: clobber 10:05:09 INFO - rmtree: /builds/slave/test/build 10:05:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:09 INFO - Running post-action listener: _resource_record_post_action 10:05:09 INFO - ##### 10:05:09 INFO - ##### Finished clobber step (success) 10:05:09 INFO - ##### 10:05:09 INFO - ##### 10:05:09 INFO - ##### Running read-buildbot-config step. 10:05:09 INFO - ##### 10:05:09 INFO - Running pre-action listener: _resource_record_pre_action 10:05:09 INFO - Running main action method: read_buildbot_config 10:05:09 INFO - Using buildbot properties: 10:05:09 INFO - { 10:05:09 INFO - "project": "", 10:05:09 INFO - "product": "firefox", 10:05:09 INFO - "script_repo_revision": "production", 10:05:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:05:09 INFO - "repository": "", 10:05:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:05:09 INFO - "buildid": "20160602073025", 10:05:09 INFO - "pgo_build": "True", 10:05:09 INFO - "basedir": "/builds/slave/test", 10:05:09 INFO - "buildnumber": 466, 10:05:09 INFO - "slavename": "talos-linux64-ix-018", 10:05:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:05:09 INFO - "platform": "ubuntu64_hw", 10:05:09 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:05:09 INFO - "branch": "mozilla-central", 10:05:09 INFO - "repo_path": "mozilla-central", 10:05:09 INFO - "revision": "92e0c73391e71a400e2c6674bca5ca70804ab081", 10:05:09 INFO - "stage_platform": "linux64-pgo", 10:05:09 INFO - "builduid": "1b0cdb8a6e1a4ba782c27240840fc38c", 10:05:09 INFO - "slavebuilddir": "test" 10:05:09 INFO - } 10:05:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:05:09 INFO - Running post-action listener: _resource_record_post_action 10:05:09 INFO - ##### 10:05:09 INFO - ##### Finished read-buildbot-config step (success) 10:05:09 INFO - ##### 10:05:09 INFO - ##### 10:05:09 INFO - ##### Running download-and-extract step. 10:05:09 INFO - ##### 10:05:09 INFO - Running pre-action listener: _resource_record_pre_action 10:05:09 INFO - Running main action method: download_and_extract 10:05:09 INFO - mkdir: /builds/slave/test/build/tests 10:05:09 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')]} 10:05:09 INFO - https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:05:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:05:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:05:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:05:10 INFO - Downloaded 1361 bytes. 10:05:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:05:10 INFO - Using the following test package requirements: 10:05:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:05:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:10 INFO - u'jsshell-linux-x86_64.zip'], 10:05:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:10 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')]} 10:05:10 INFO - https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:05:11 INFO - Downloaded 24423273 bytes. 10:05:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:05:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:05:12 INFO - Return code: 0 10:05:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:12 INFO - https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:05:13 INFO - Downloaded 24423273 bytes. 10:05:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:05:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:05:15 INFO - Return code: 0 10:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:15 INFO - https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:05:16 INFO - Downloaded 10834055 bytes. 10:05:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:05:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:05:16 INFO - Return code: 0 10:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:16 INFO - https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:05:18 INFO - Downloaded 59049213 bytes. 10:05:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:18 INFO - mkdir: /builds/slave/test/properties 10:05:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:18 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:18 INFO - Contents: 10:05:18 INFO - build_url:https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:05:19 INFO - Running post-action listener: _resource_record_post_action 10:05:19 INFO - Running post-action listener: set_extra_try_arguments 10:05:19 INFO - ##### 10:05:19 INFO - ##### Finished download-and-extract step (success) 10:05:19 INFO - ##### 10:05:19 INFO - ##### 10:05:19 INFO - ##### Running populate-webroot step. 10:05:19 INFO - ##### 10:05:19 INFO - Running pre-action listener: _resource_record_pre_action 10:05:19 INFO - Running main action method: populate_webroot 10:05:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:19 INFO - '--tppagecycles', 10:05:19 INFO - '7'], 10:05:19 INFO - 'tests': ['tsvgm']}}, 10:05:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:19 INFO - 'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:19 INFO - 'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['damp', 'tps']}, 10:05:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:19 INFO - 'tests': ['damp', 'tps']}, 10:05:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['dromaeo_dom']}, 10:05:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['a11yr', 10:05:19 INFO - 'ts_paint', 10:05:19 INFO - 'tpaint', 10:05:19 INFO - 'sessionrestore', 10:05:19 INFO - 'sessionrestore_no_auto_restore', 10:05:19 INFO - 'tabpaint']}, 10:05:19 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:19 INFO - 'ts_paint', 10:05:19 INFO - 'tpaint', 10:05:19 INFO - 'sessionrestore', 10:05:19 INFO - 'sessionrestore_no_auto_restore', 10:05:19 INFO - 'tabpaint']}, 10:05:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:19 INFO - 'ts_paint', 10:05:19 INFO - 'tpaint', 10:05:19 INFO - 'sessionrestore', 10:05:19 INFO - 'sessionrestore_no_auto_restore', 10:05:19 INFO - 'tabpaint']}, 10:05:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:19 INFO - 'ts_paint', 10:05:19 INFO - 'tpaint', 10:05:19 INFO - 'sessionrestore', 10:05:19 INFO - 'sessionrestore_no_auto_restore', 10:05:19 INFO - 'tabpaint']}, 10:05:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['a11yr', 10:05:19 INFO - 'ts_paint', 10:05:19 INFO - 'tpaint', 10:05:19 INFO - 'sessionrestore', 10:05:19 INFO - 'sessionrestore_no_auto_restore', 10:05:19 INFO - 'tabpaint']}, 10:05:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['a11yr', 10:05:19 INFO - 'ts_paint', 10:05:19 INFO - 'tpaint', 10:05:19 INFO - 'sessionrestore', 10:05:19 INFO - 'sessionrestore_no_auto_restore', 10:05:19 INFO - 'tabpaint']}, 10:05:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['tsvgx', 10:05:19 INFO - 'tsvgr_opacity', 10:05:19 INFO - 'tart', 10:05:19 INFO - 'tscrollx', 10:05:19 INFO - 'cart']}, 10:05:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:19 INFO - 'tsvgr_opacity', 10:05:19 INFO - 'tart', 10:05:19 INFO - 'tscrollx', 10:05:19 INFO - 'cart']}, 10:05:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:19 INFO - 'talos_options': ['--disable-e10s'], 10:05:19 INFO - 'tests': ['tp5o']}, 10:05:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:19 INFO - 'tests': ['tp5o']}, 10:05:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:19 INFO - 'talos_options': ['--disable-e10s', 10:05:19 INFO - '--xperf_path', 10:05:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:19 INFO - 'tests': ['tp5n']}, 10:05:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:19 INFO - 'talos_options': ['--xperf_path', 10:05:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:19 INFO - 'tests': ['tp5n']}}, 10:05:19 INFO - 'talos.zip': {'path': '', 10:05:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:19 INFO - Running post-action listener: _resource_record_post_action 10:05:19 INFO - ##### 10:05:19 INFO - ##### Finished populate-webroot step (success) 10:05:19 INFO - ##### 10:05:19 INFO - ##### 10:05:19 INFO - ##### Running create-virtualenv step. 10:05:19 INFO - ##### 10:05:19 INFO - Running pre-action listener: _resource_record_pre_action 10:05:19 INFO - Running main action method: create_virtualenv 10:05:19 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:19 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 10:05:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:19 INFO - Using real prefix '/usr' 10:05:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:19 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:21 INFO - Installing pip.................done. 10:05:21 INFO - Return code: 0 10:05:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:05:21 INFO - Using env: {'DISPLAY': ':0', 10:05:21 INFO - 'HOME': '/home/cltbld', 10:05:21 INFO - 'LANG': 'en_US.UTF-8', 10:05:21 INFO - 'LANGUAGE': 'en_US:en', 10:05:21 INFO - 'LOGNAME': 'cltbld', 10:05:21 INFO - 'MAIL': '/var/mail/cltbld', 10:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:21 INFO - 'MOZ_NO_REMOTE': '1', 10:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:21 INFO - 'NO_EM_RESTART': '1', 10:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:21 INFO - 'PWD': '/builds/slave/test', 10:05:21 INFO - 'SHELL': '/bin/bash', 10:05:21 INFO - 'SHLVL': '1', 10:05:21 INFO - 'TERM': 'linux', 10:05:21 INFO - 'TMOUT': '86400', 10:05:21 INFO - 'USER': 'cltbld', 10:05:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:21 INFO - '_': '/tools/buildbot/bin/python'} 10:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:05:21 INFO - Cleaning up... 10:05:21 INFO - Return code: 0 10:05:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:05:21 INFO - Using env: {'DISPLAY': ':0', 10:05:21 INFO - 'HOME': '/home/cltbld', 10:05:21 INFO - 'LANG': 'en_US.UTF-8', 10:05:21 INFO - 'LANGUAGE': 'en_US:en', 10:05:21 INFO - 'LOGNAME': 'cltbld', 10:05:21 INFO - 'MAIL': '/var/mail/cltbld', 10:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:21 INFO - 'MOZ_NO_REMOTE': '1', 10:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:21 INFO - 'NO_EM_RESTART': '1', 10:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:21 INFO - 'PWD': '/builds/slave/test', 10:05:21 INFO - 'SHELL': '/bin/bash', 10:05:21 INFO - 'SHLVL': '1', 10:05:21 INFO - 'TERM': 'linux', 10:05:21 INFO - 'TMOUT': '86400', 10:05:21 INFO - 'USER': 'cltbld', 10:05:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:21 INFO - '_': '/tools/buildbot/bin/python'} 10:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:22 INFO - Downloading/unpacking psutil>=3.1.1 10:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:24 INFO - Installing collected packages: psutil 10:05:24 INFO - Running setup.py install for psutil 10:05:24 INFO - building 'psutil._psutil_linux' extension 10:05:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:05:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:05:24 INFO - building 'psutil._psutil_posix' extension 10:05:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:05:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:05:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:24 INFO - Successfully installed psutil 10:05:24 INFO - Cleaning up... 10:05:24 INFO - Return code: 0 10:05:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:05:24 INFO - Using env: {'DISPLAY': ':0', 10:05:24 INFO - 'HOME': '/home/cltbld', 10:05:24 INFO - 'LANG': 'en_US.UTF-8', 10:05:24 INFO - 'LANGUAGE': 'en_US:en', 10:05:24 INFO - 'LOGNAME': 'cltbld', 10:05:24 INFO - 'MAIL': '/var/mail/cltbld', 10:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:24 INFO - 'MOZ_NO_REMOTE': '1', 10:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:24 INFO - 'NO_EM_RESTART': '1', 10:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:24 INFO - 'PWD': '/builds/slave/test', 10:05:24 INFO - 'SHELL': '/bin/bash', 10:05:24 INFO - 'SHLVL': '1', 10:05:24 INFO - 'TERM': 'linux', 10:05:24 INFO - 'TMOUT': '86400', 10:05:24 INFO - 'USER': 'cltbld', 10:05:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:24 INFO - '_': '/tools/buildbot/bin/python'} 10:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:26 INFO - Installing collected packages: mozsystemmonitor 10:05:26 INFO - Running setup.py install for mozsystemmonitor 10:05:26 INFO - Successfully installed mozsystemmonitor 10:05:26 INFO - Cleaning up... 10:05:26 INFO - Return code: 0 10:05:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:05:26 INFO - Using env: {'DISPLAY': ':0', 10:05:26 INFO - 'HOME': '/home/cltbld', 10:05:26 INFO - 'LANG': 'en_US.UTF-8', 10:05:26 INFO - 'LANGUAGE': 'en_US:en', 10:05:26 INFO - 'LOGNAME': 'cltbld', 10:05:26 INFO - 'MAIL': '/var/mail/cltbld', 10:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:26 INFO - 'MOZ_NO_REMOTE': '1', 10:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:26 INFO - 'NO_EM_RESTART': '1', 10:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:26 INFO - 'PWD': '/builds/slave/test', 10:05:26 INFO - 'SHELL': '/bin/bash', 10:05:26 INFO - 'SHLVL': '1', 10:05:26 INFO - 'TERM': 'linux', 10:05:26 INFO - 'TMOUT': '86400', 10:05:26 INFO - 'USER': 'cltbld', 10:05:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:26 INFO - '_': '/tools/buildbot/bin/python'} 10:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:27 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:27 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 10:05:27 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 10:05:27 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 10:05:27 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 10:05:27 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 10:05:27 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 10:05:28 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:29 INFO - Downloading docopt-0.6.1.tar.gz 10:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:29 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:29 INFO - Running setup.py install for blobuploader 10:05:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:29 INFO - Running setup.py install for requests 10:05:30 INFO - Running setup.py install for docopt 10:05:30 INFO - Successfully installed blobuploader requests docopt 10:05:30 INFO - Cleaning up... 10:05:30 INFO - Return code: 0 10:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:05:30 INFO - Using env: {'DISPLAY': ':0', 10:05:30 INFO - 'HOME': '/home/cltbld', 10:05:30 INFO - 'LANG': 'en_US.UTF-8', 10:05:30 INFO - 'LANGUAGE': 'en_US:en', 10:05:30 INFO - 'LOGNAME': 'cltbld', 10:05:30 INFO - 'MAIL': '/var/mail/cltbld', 10:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:30 INFO - 'MOZ_NO_REMOTE': '1', 10:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:30 INFO - 'NO_EM_RESTART': '1', 10:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:30 INFO - 'PWD': '/builds/slave/test', 10:05:30 INFO - 'SHELL': '/bin/bash', 10:05:30 INFO - 'SHLVL': '1', 10:05:30 INFO - 'TERM': 'linux', 10:05:30 INFO - 'TMOUT': '86400', 10:05:30 INFO - 'USER': 'cltbld', 10:05:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:30 INFO - '_': '/tools/buildbot/bin/python'} 10:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:30 INFO - Running setup.py (path:/tmp/pip-WAwaU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:30 INFO - Running setup.py (path:/tmp/pip-HiFfrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:30 INFO - Running setup.py (path:/tmp/pip-0x3Wac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:30 INFO - Running setup.py (path:/tmp/pip-AV4HZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:30 INFO - Running setup.py (path:/tmp/pip-sWeNN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:30 INFO - Running setup.py (path:/tmp/pip-tpAO4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:30 INFO - Running setup.py (path:/tmp/pip-wS2rdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:31 INFO - Running setup.py (path:/tmp/pip-vWhLjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:31 INFO - Running setup.py (path:/tmp/pip-U4Uvix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:31 INFO - Running setup.py (path:/tmp/pip-Y3evyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:31 INFO - Running setup.py (path:/tmp/pip-nH4c8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:31 INFO - Running setup.py (path:/tmp/pip-Seym_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:31 INFO - Running setup.py (path:/tmp/pip-EOk8pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:31 INFO - Running setup.py (path:/tmp/pip-gQ1swe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:31 INFO - Running setup.py (path:/tmp/pip-hLoHss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:31 INFO - Running setup.py (path:/tmp/pip-klqkea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:31 INFO - Running setup.py (path:/tmp/pip-Tv4I_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:31 INFO - Running setup.py install for manifestparser 10:05:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:31 INFO - Running setup.py install for mozcrash 10:05:31 INFO - Running setup.py install for mozdebug 10:05:32 INFO - Running setup.py install for mozdevice 10:05:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Running setup.py install for mozfile 10:05:32 INFO - Running setup.py install for mozhttpd 10:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Running setup.py install for mozinfo 10:05:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Running setup.py install for mozInstall 10:05:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Running setup.py install for mozleak 10:05:32 INFO - Running setup.py install for mozlog 10:05:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Running setup.py install for moznetwork 10:05:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:32 INFO - Running setup.py install for mozprocess 10:05:32 INFO - Running setup.py install for mozprofile 10:05:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:33 INFO - Running setup.py install for mozrunner 10:05:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:33 INFO - Running setup.py install for mozscreenshot 10:05:33 INFO - Running setup.py install for moztest 10:05:33 INFO - Running setup.py install for mozversion 10:05:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:33 INFO - Cleaning up... 10:05:33 INFO - Return code: 0 10:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:05:33 INFO - Using env: {'DISPLAY': ':0', 10:05:33 INFO - 'HOME': '/home/cltbld', 10:05:33 INFO - 'LANG': 'en_US.UTF-8', 10:05:33 INFO - 'LANGUAGE': 'en_US:en', 10:05:33 INFO - 'LOGNAME': 'cltbld', 10:05:33 INFO - 'MAIL': '/var/mail/cltbld', 10:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:33 INFO - 'MOZ_NO_REMOTE': '1', 10:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:33 INFO - 'NO_EM_RESTART': '1', 10:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:33 INFO - 'PWD': '/builds/slave/test', 10:05:33 INFO - 'SHELL': '/bin/bash', 10:05:33 INFO - 'SHLVL': '1', 10:05:33 INFO - 'TERM': 'linux', 10:05:33 INFO - 'TMOUT': '86400', 10:05:33 INFO - 'USER': 'cltbld', 10:05:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:33 INFO - '_': '/tools/buildbot/bin/python'} 10:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:33 INFO - Running setup.py (path:/tmp/pip-GE8on5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:33 INFO - Running setup.py (path:/tmp/pip-LehtFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:33 INFO - Running setup.py (path:/tmp/pip-XUgENx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:33 INFO - Running setup.py (path:/tmp/pip-WkHNjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:34 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)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:34 INFO - Running setup.py (path:/tmp/pip-HfoL8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:34 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)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:34 INFO - Running setup.py (path:/tmp/pip-4daKZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:34 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)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:34 INFO - Running setup.py (path:/tmp/pip-gSaZZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:34 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)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:34 INFO - Running setup.py (path:/tmp/pip-RbGDxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:34 INFO - Running setup.py (path:/tmp/pip-RGVem4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:34 INFO - Running setup.py (path:/tmp/pip-sOZRU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:34 INFO - Running setup.py (path:/tmp/pip-PyrvT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:34 INFO - Running setup.py (path:/tmp/pip-tTRWVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:34 INFO - Running setup.py (path:/tmp/pip-uNir5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:34 INFO - Running setup.py (path:/tmp/pip-5VLU0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:34 INFO - Running setup.py (path:/tmp/pip-zSHss9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:34 INFO - Running setup.py (path:/tmp/pip-G7HS2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:34 INFO - Running setup.py (path:/tmp/pip-kF39Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:36 INFO - Downloading blessings-1.6.tar.gz 10:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:36 INFO - Installing collected packages: blessings 10:05:36 INFO - Running setup.py install for blessings 10:05:37 INFO - Successfully installed blessings 10:05:37 INFO - Cleaning up... 10:05:37 INFO - Return code: 0 10:05:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:37 INFO - Reading from file tmpfile_stdout 10:05:37 INFO - Current package versions: 10:05:37 INFO - argparse == 1.2.1 10:05:37 INFO - blessings == 1.6 10:05:37 INFO - blobuploader == 1.2.4 10:05:37 INFO - docopt == 0.6.1 10:05:37 INFO - manifestparser == 1.1 10:05:37 INFO - mozInstall == 1.12 10:05:37 INFO - mozcrash == 0.17 10:05:37 INFO - mozdebug == 0.1 10:05:37 INFO - mozdevice == 0.48 10:05:37 INFO - mozfile == 1.2 10:05:37 INFO - mozhttpd == 0.7 10:05:37 INFO - mozinfo == 0.9 10:05:37 INFO - mozleak == 0.1 10:05:37 INFO - mozlog == 3.2 10:05:37 INFO - moznetwork == 0.27 10:05:37 INFO - mozprocess == 0.22 10:05:37 INFO - mozprofile == 0.28 10:05:37 INFO - mozrunner == 6.11 10:05:37 INFO - mozscreenshot == 0.1 10:05:37 INFO - mozsystemmonitor == 0.3 10:05:37 INFO - moztest == 0.7 10:05:37 INFO - mozversion == 1.4 10:05:37 INFO - psutil == 3.1.1 10:05:37 INFO - requests == 1.2.3 10:05:37 INFO - wsgiref == 0.1.2 10:05:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:37 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 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:37 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 10:05:37 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 10:05:37 INFO - Using env: {'DISPLAY': ':0', 10:05:37 INFO - 'HOME': '/home/cltbld', 10:05:37 INFO - 'LANG': 'en_US.UTF-8', 10:05:37 INFO - 'LANGUAGE': 'en_US:en', 10:05:37 INFO - 'LOGNAME': 'cltbld', 10:05:37 INFO - 'MAIL': '/var/mail/cltbld', 10:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:37 INFO - 'MOZ_NO_REMOTE': '1', 10:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:37 INFO - 'NO_EM_RESTART': '1', 10:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:37 INFO - 'PWD': '/builds/slave/test', 10:05:37 INFO - 'SHELL': '/bin/bash', 10:05:37 INFO - 'SHLVL': '1', 10:05:37 INFO - 'TERM': 'linux', 10:05:37 INFO - 'TMOUT': '86400', 10:05:37 INFO - 'USER': 'cltbld', 10:05:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:37 INFO - '_': '/tools/buildbot/bin/python'} 10:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:05:37 INFO - Cleaning up... 10:05:37 INFO - Return code: 0 10:05:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:05:37 INFO - Using env: {'DISPLAY': ':0', 10:05:37 INFO - 'HOME': '/home/cltbld', 10:05:37 INFO - 'LANG': 'en_US.UTF-8', 10:05:37 INFO - 'LANGUAGE': 'en_US:en', 10:05:37 INFO - 'LOGNAME': 'cltbld', 10:05:37 INFO - 'MAIL': '/var/mail/cltbld', 10:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:37 INFO - 'MOZ_NO_REMOTE': '1', 10:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:37 INFO - 'NO_EM_RESTART': '1', 10:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:37 INFO - 'PWD': '/builds/slave/test', 10:05:37 INFO - 'SHELL': '/bin/bash', 10:05:37 INFO - 'SHLVL': '1', 10:05:37 INFO - 'TERM': 'linux', 10:05:37 INFO - 'TMOUT': '86400', 10:05:37 INFO - 'USER': 'cltbld', 10:05:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:37 INFO - '_': '/tools/buildbot/bin/python'} 10:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:37 INFO - Downloading/unpacking jsonschema 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:39 INFO - Downloading/unpacking functools32 (from jsonschema) 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:39 INFO - warning: no files found matching '*.txt' 10:05:39 INFO - no previously-included directories found matching 'build' 10:05:39 INFO - no previously-included directories found matching 'dist' 10:05:39 INFO - no previously-included directories found matching '.git*' 10:05:39 INFO - Installing collected packages: jsonschema, functools32 10:05:39 INFO - Running setup.py install for functools32 10:05:40 INFO - warning: no files found matching '*.txt' 10:05:40 INFO - no previously-included directories found matching 'build' 10:05:40 INFO - no previously-included directories found matching 'dist' 10:05:40 INFO - no previously-included directories found matching '.git*' 10:05:40 INFO - Successfully installed jsonschema functools32 10:05:40 INFO - Cleaning up... 10:05:40 INFO - Return code: 0 10:05:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:05:40 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')]} 10:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 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')]} 10:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:40 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 0x7f7a37681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', '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 10:05:40 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 10:05:40 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 10:05:40 INFO - Using env: {'DISPLAY': ':0', 10:05:40 INFO - 'HOME': '/home/cltbld', 10:05:40 INFO - 'LANG': 'en_US.UTF-8', 10:05:40 INFO - 'LANGUAGE': 'en_US:en', 10:05:40 INFO - 'LOGNAME': 'cltbld', 10:05:40 INFO - 'MAIL': '/var/mail/cltbld', 10:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:40 INFO - 'MOZ_NO_REMOTE': '1', 10:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:40 INFO - 'NO_EM_RESTART': '1', 10:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:40 INFO - 'PWD': '/builds/slave/test', 10:05:40 INFO - 'SHELL': '/bin/bash', 10:05:40 INFO - 'SHLVL': '1', 10:05:40 INFO - 'TERM': 'linux', 10:05:40 INFO - 'TMOUT': '86400', 10:05:40 INFO - 'USER': 'cltbld', 10:05:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:40 INFO - '_': '/tools/buildbot/bin/python'} 10:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:40 INFO - Downloading/unpacking flake8 10:05:40 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 10:05:40 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 10:05:40 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 10:05:40 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 10:05:40 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 10:05:40 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 10:05:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:05:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:42 INFO - no previously-included directories found matching 'docs/_build' 10:05:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:43 INFO - Running setup.py install for pep8 10:05:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:43 INFO - no previously-included directories found matching 'docs/_build' 10:05:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:05:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:43 INFO - Cleaning up... 10:05:43 INFO - Return code: 0 10:05:43 INFO - Running post-action listener: _resource_record_post_action 10:05:43 INFO - Running post-action listener: _start_resource_monitoring 10:05:43 INFO - Starting resource monitoring. 10:05:43 INFO - ##### 10:05:43 INFO - ##### Finished create-virtualenv step (success) 10:05:43 INFO - ##### 10:05:43 INFO - ##### 10:05:43 INFO - ##### Running install step. 10:05:43 INFO - ##### 10:05:43 INFO - Running pre-action listener: _resource_record_pre_action 10:05:43 INFO - Running main action method: install 10:05:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:43 INFO - Reading from file tmpfile_stdout 10:05:43 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:43 INFO - Reading from file tmpfile_stdout 10:05:43 INFO - Output received: 10:05:43 INFO - Usage: mozinstall [options] installer 10:05:43 INFO - Options: 10:05:43 INFO - -h, --help show this help message and exit 10:05:43 INFO - -d DEST, --destination=DEST 10:05:43 INFO - Directory to install application into. [default: 10:05:43 INFO - "/builds/slave/test"] 10:05:43 INFO - --app=APP Application being installed. [default: firefox] 10:05:43 INFO - mkdir: /builds/slave/test/build/application 10:05:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:06:00 INFO - Reading from file tmpfile_stdout 10:06:00 INFO - Output received: 10:06:00 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:00 INFO - Running post-action listener: _resource_record_post_action 10:06:00 INFO - ##### 10:06:00 INFO - ##### Finished install step (success) 10:06:00 INFO - ##### 10:06:00 INFO - ##### 10:06:00 INFO - ##### Running run-tests step. 10:06:00 INFO - ##### 10:06:00 INFO - Running pre-action listener: _resource_record_pre_action 10:06:00 INFO - Running main action method: run_tests 10:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:00 INFO - Python 2.7.3 10:06:00 INFO - Return code: 0 10:06:00 INFO - grabbing minidump binary from tooltool 10:06: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')]} 10:06:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23439c0>, '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 0x23448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2344d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:00 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 10:06:00 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 10:06:00 INFO - Calling ['/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'] with output_timeout 600 10:06:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:00 INFO - Return code: 0 10:06:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:06:01 INFO - Return code: 0 10:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:06:01 INFO - Using env: {'DISPLAY': ':0', 10:06:01 INFO - 'HOME': '/home/cltbld', 10:06:01 INFO - 'LANG': 'en_US.UTF-8', 10:06:01 INFO - 'LANGUAGE': 'en_US:en', 10:06:01 INFO - 'LOGNAME': 'cltbld', 10:06:01 INFO - 'MAIL': '/var/mail/cltbld', 10:06:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:01 INFO - 'MOZ_NO_REMOTE': '1', 10:06:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:01 INFO - 'NO_EM_RESTART': '1', 10:06:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:01 INFO - 'PWD': '/builds/slave/test', 10:06:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:01 INFO - 'SHELL': '/bin/bash', 10:06:01 INFO - 'SHLVL': '1', 10:06:01 INFO - 'TERM': 'linux', 10:06:01 INFO - 'TMOUT': '86400', 10:06:01 INFO - 'USER': 'cltbld', 10:06:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302', 10:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:01 INFO - '_': '/tools/buildbot/bin/python'} 10:06:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:06:01 INFO - mozversion application_buildid: 20160602073025 10:06:01 INFO - mozversion application_changeset: 92e0c73391e71a400e2c6674bca5ca70804ab081 10:06:01 INFO - mozversion application_display_name: Nightly 10:06:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:01 INFO - mozversion application_name: Firefox 10:06:01 INFO - mozversion application_remotingname: firefox 10:06:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:06:01 INFO - mozversion application_vendor: Mozilla 10:06:01 INFO - mozversion application_version: 49.0a1 10:06:01 INFO - mozversion platform_buildid: 20160602073025 10:06:01 INFO - mozversion platform_changeset: 92e0c73391e71a400e2c6674bca5ca70804ab081 10:06:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:06:01 INFO - mozversion platform_version: 49.0a1 10:06:01 INFO - using testdate: 1464887161 10:06:01 INFO - actual date: 1464887161 10:06:01 INFO - starting webserver on 'localhost:57781' 10:06:01 INFO - SUITE-START | Running 2 tests 10:06:01 INFO - TEST-START | dromaeo_css 10:06:01 INFO - operating with platform_type : linux_ 10:06:01 INFO - Initialising browser for dromaeo_css test... 10:06:01 INFO - TEST-INFO | started process 23518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmply3Ti8/profile http://localhost:57781/getInfo.html) 10:06:05 INFO - PROCESS | 23518 | __metrics Screen width/height:1600/1200 10:06:05 INFO - PROCESS | 23518 | colorDepth:24 10:06:05 INFO - PROCESS | 23518 | Browser inner width/height: 1024/697 10:06:05 INFO - PROCESS | 23518 | __metrics 10:06:06 ERROR - PROCESS | 23518 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:06:06 INFO - TEST-INFO | 23518: exit 0 10:06:06 INFO - Browser initialized. 10:06:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:06 INFO - TEST-INFO | started process 23598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmply3Ti8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:18 INFO - PROCESS | 23598 | RSS: Main: 155951104 10:06:18 INFO - PROCESS | 23598 | 10:07:09 INFO - PROCESS | 23598 | 1464887229576 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] 10:09:17 INFO - PROCESS | 23598 | Cycle 1(1): loaded http://localhost:57781/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57781/tests/dromaeo/cssquery-ext.html) 10:09:18 INFO - PROCESS | 23598 | RSS: Main: 244146176 10:09:18 INFO - PROCESS | 23598 | 10:12:20 INFO - PROCESS | 23598 | Cycle 1(1): loaded http://localhost:57781/tests/dromaeo/cssquery-ext.html (next: http://localhost:57781/tests/dromaeo/cssquery-jquery.html) 10:12:21 INFO - PROCESS | 23598 | RSS: Main: 245149696 10:12:21 INFO - PROCESS | 23598 | 10:15:23 INFO - PROCESS | 23598 | Cycle 1(1): loaded http://localhost:57781/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57781/tests/dromaeo/cssquery-mootools.html) 10:15:24 INFO - PROCESS | 23598 | RSS: Main: 239837184 10:15:24 INFO - PROCESS | 23598 | 10:18:26 INFO - PROCESS | 23598 | Cycle 1(1): loaded http://localhost:57781/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57781/tests/dromaeo/cssquery-prototype.html) 10:18:26 INFO - PROCESS | 23598 | RSS: Main: 236855296 10:18:26 INFO - PROCESS | 23598 | 10:21:29 INFO - PROCESS | 23598 | Cycle 1(1): loaded http://localhost:57781/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57781/tests/dromaeo/cssquery-yui.html) 10:21:30 INFO - PROCESS | 23598 | RSS: Main: 221372416 10:21:30 INFO - PROCESS | 23598 | 10:24:32 INFO - PROCESS | 23598 | Cycle 1(1): loaded http://localhost:57781/tests/dromaeo/cssquery-yui.html (next: http://localhost:57781/tests/dromaeo/cssquery-dojo.html) 10:24:33 INFO - PROCESS | 23598 | RSS: Main: 323633152 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - PROCESS | 23598 | __start_tp_report 10:24:33 INFO - PROCESS | 23598 | _x_x_mozilla_page_load 10:24:33 INFO - PROCESS | 23598 | _x_x_mozilla_page_load_details 10:24:33 INFO - PROCESS | 23598 | |i|pagename|runs| 10:24:33 INFO - PROCESS | 23598 | |0;dojo.html;3128.249220187155;3150.54317124017;3167.3190264093214;3188.5536024956523;3211.9839400802994;5312.654677445963;5374.811881584145;5417.918731219025;5486.3690675572325;5515.806946756859;5375.408705042442;5381.67709937404;5391.002664507059;5405.5135037846585;5437.13005919053;4795.184818580841;4843.200871856157;5024.723640199788;5075.289459475676;5127.461616530267;5027.069992051483;5075.162598171298;5084.13569693153;5092.694438333693;5096.108181068298;4828;4885.804567817283;4925.876853078666;4936.777844996984;4990.326305948687;5023.6232282578585;5026.170681837492;5031.622628302892;5033.672811267256;5096.286519887219;4970.204767237261;4998.850034498971;5012.047710934947;5014.974925125388;5016.724080175589;5168.53483186515;5294.100002999499;5338.893222135574;5396.028714831329;5523.4200408956885;5794.420557944214;5826.096954971986;5828.2131912191735;5915.674637894914;5924.022536281508;5933.376995415462;5949.821505354803;5956.880862382728;5961.672108034057;5966;5299.920501192485;5312.203169524563;5367.275417818583;5377.623566350318;5398.352197736297;5938.940610593839;5948.7323070461935;5954.345022047572;5958.046712525975;5966.105084237399;5511.834644960658;5723.284589426322;5723.771049157987;5727.656340619576;5731.111677689964;5760.991826430358;5827.213326200994;5832.591718579743;5858.2677165354335;5861.1501332307425;5813.854653633608;5818.301803783573;5819.6508209507565;5826.825195244065;5837.357890632027;5584.274044374205;5661.405552416937;5798.159266906275;5824.883502330014;5844.094165404369;4319.827206911751;4381.342798580238;4394.934075988863;4422.911541769211;4425.911481770411;3915.6084391560616;3925.568187499373;3925.764454132704;3953.920921581552;3957.920841583152;5369.24830523727;5413.02565538199;5461.1808228766;5469.398366179717;5477.096279113902;5684.6589204647025;5735.799247026417;5742.712864356849;5749.655020698771;5785.537157027512;5422;5446.101393270066;5447.591430642718;5459.5632349412745;5460.126379779216;4904.509549045139;4933.358663373739;4946.950530494721;4957.7769000395065;5006.89986200274;5959.821205363846;6068.4538391544975;6069.02895536712;6082.300535438393;6133.938660613426;5898.587098903035;5899.085641725539;5906.970465147647;5907.675077870758;5907.940920590739;5726.997775389207;5975.37258587842;6031.849203769941;6056.848578785565;6062.7271772769445;5787.189793429007;5806.477417032487;5812.128180772918;5827.79602713903;5858.2677165354335;5869.119632055226;5902.675352855634;5909.261342332208;5910.261217347832;5919.171316015675;5553.416891226363;5677.858053548694;5719.656820590778;5749.252597162342;5762;5738.254026976467;5744.684042377542;5750.30996280449;5753;5758.1650660654805;5657.971710141423;5667.093265077568;5668.631538949955;5670.09278515452;5672.574556908331;5596.076647353141;5635.154726791015;5674.432556744293;5699.544036477155;5799.681017544076;5595.160725891149;5620.550355971594;5622.803201887914;5632.718364081861;5664.801731939362 10:24:33 INFO - PROCESS | 23598 | |1;ext.html;582.9067349224123;609.8841220168168;610.0787810406288;626.6208943589131;631.7946667333118;31624.84187579062;32273.35453290933;34615.480767788504;34785.478217826756;34791.304173916506;45712;46547.534524654744;46690.99999999991;50443.74778126113;50471.74764126174;8646.610902509387;8817.911820881773;8821.73534793954;8832.779180520474;8835.95582022089;8598.957005214965;8737.388382813206;8743.475391476532;8745.737627871174;8747.475151490931;8734.737957861242;8783.209511143996;8786.341024423162;8787.077356877531;8797.780055498632;8657.091005444432;8720.171583699539;8730.607122679494;8732.912670873306;8736.170063843925;8614.612342444605;8709.432302185603;8709.520976346299;8712.912870871274;8714.825703485958;42792;43275.350869736976;43342.34986475174;43355.34966975498;43370.56629433697;3335.449650807614;3913.960860391388;4068.6338229559483;4121.196366708493;4194.832206711759;32721.181970450692;32890;32996.50505242423;33444.49833252503;33616.32767344664;4204.831806727727;4265.7440553566885;4275.422817919603;4444.133393988173;4510.684252102355;340841.2957935219;345091;345279;345776;347790;52898;53092.73453632707;53411.732941335045;53426.46573534293;53452.73273633607;55457.44542554604;62043.37956620376;63629;63640.68179659072;68818.65590672015;17297.962122272704;17581.120943952752;17602.91198543999;17604.559886002953;17621.823781762017;13351.265680387673;13595.796063059062;13624.18254904709;13625.659358515919;13633.318334083257;16100.677986440205;16967.49097527076;17373.7393939091;17408.303667853143;17454.301827926996;6684.598924064571;6693.933060669428;6716.671327553896;6794.830129246809;6973.19808222061;930.4556834251903;1057.6509751781894;1117.2570240789785;1151.8675352334421;1223.2721530689225;32264.19339516484;32579;32821.507677384856;33126.834365828014;33335;1145.3643228008534;1164.2665120973902;1193.3794426897964;1242.0498318786135;1242.2732701369619;16869.32522699103;17335.56661083483;17357.47927562175;17467;17628.735568966476;521176;521252.7561535328;521822;522042;523890;59149.40850591525;59612.403875960685;59614.10578841321;59621;59681.403185968455;1259.741752940645;1366.3782978744648;1393.979090313646;1396.8533304002933;1400.9369578368999;32349.838250808596;33620.663793362735;33701.831490842385;34000.31999360048;34248.82875585606;51056.744716277666;51388.48611513837;51561.71095722487;51576.74211628918;51857.22214166866;400498;402494;402857;402980;403427;32530;40921.59078409178;41521.584784151775;45088.774556127006;45190.09619807651;47662.76168619135;47971.280430794264;48630.513694864014;48753.2687009688;49254.75372623114;41628.1674366517;42316.576834231266;42444.36333454939;42575;42744.35883461813;41282.1743565133;41571.58428415677;41826.79086604548;41901.580984189764;42305;40925;41661.37507937444;42740.57259427366;42772.57227427811;42818;35338.646613533536;36519.45220821743;36698.26603467969;37270.6272937278;37556;28083.71916280811;28213.858930705213;28547;28572.285692857844;28685.139445816658 10:24:33 INFO - PROCESS | 23598 | |2;jquery.html;384.67494966753094;384.76529317116535;397.6302039103636;400.3014739279956;414.09107010112797;14210.644733881658;16650.750238746397;18265.817341826594;19763.209471621136;19794.406167814952;19042.33351832686;19214.615707685836;19312.903435482836;19804.70292945607;19820.20719171235;5444.863878403042;5543.805966791163;5588.105903055512;5588.105903055512;5589.357223919261;4057.229126465962;5389.191621256804;5568.136938774496;5582.413846546115;5998.25021872266;6242;6334.461570766491;6346.84132896679;6356.269029061647;6361.2048493938255;6102.511799056065;6268.15379923709;6325.746970121189;6342.936570634304;6346.2067241594805;5499.790046189872;5503.972480137613;5518.558515318765;5525.723713814334;5531.612787104904;22381.664275035888;22948.885255573783;23402.297931062094;23664.40838979022;23692.170774022827;2384.3562238195764;2386.176769014687;2403.038784486202;2482.1808803095114;2487.0176280369333;13868;14120.717585648332;14121.223332716696;14467.638309042253;14879.404823807035;1850.463365623981;1882.7552418185685;1914.301280032778;1936.5158710322419;1984;53039.46960530384;53304;70801.6459917697;82694.75957860576;82872;10246.53890574926;10692.144628429707;10769.88430495524;10804.24370294072;10903.454827258605;13060.869391306156;13510.932445337907;14501.564953051426;15026.17356045406;15038.849611503963;8584.74245772628;8595.18345757152;8598.441101328393;8709.695160669346;8795.51624660637;8544.273736732448;8604.612792424356;8621.094785047606;8752.606132724042;8765.517896515752;6719.462443004548;6763.357481039294;6823.897641535381;6858.965705171442;6866.793996180123;1884.3310624728024;1891.215145714513;1928.758905136858;1938.4184744576853;1963.7447131872766;976.5215044628081;1078.412265315405;1125.2517076144436;1128.915331350152;1177.3583397048628;19395.806041939682;19897.60204795896;20126;20178.394648160578;20227.39317820468;1024.3700124423574;1039.3348257115451;1042.718466014172;1061.792950374685;1069;11020.889791101987;11562.595309164139;11575.710607234887;11586.47860846264;11589.304641721523;461253;465188;469233;474511;475221;52280.47719522832;52378;82127.9999999988;82649.17350826415;84858.57570712107;1053.8419237114495;1067.2262609607972;1105.4196546812987;1131.3494740524231;1131.9547218111347;17396.565085872953;17493.212805424042;17788.288468461116;17796.822031779517;17857.107144642974;28731.856340718998;37591.2481750358;38204.6179538201;38903.83288501349;39204;51961.7401912988;52571.9485610278;53132.20301695555;53899.191512128134;54139.18791218056;8593.183647553473;8735.432196907435;8784.209421152127;8796.120387961153;8920.330975177018;13403.664908377368;13417.597472075853;13482;13530.594082177551;13655.86344136546;11692.326071050205;11843;12084.39578021113;12137.939310303393;12176.964957978671;11297.26567773092;11431.256968297033;11672.182947193614;11672.824907626562;11972.281663100242;11446.828297575377;11949.163558550817;11951.760964780482;12076.396180191132;12270.815937760763;7461.552306861606;7859.056913170228;8658.307335413027;8859.158379953895;8984.505852178192;11682.824757628472;11684.88315116872;11980.221285616408;12011;12170.817437738619 10:24:33 INFO - PROCESS | 23598 | |3;mootools.html;1328.9069765116446;1508.8566586174309;1533.087812751413;1655.4867990922814;1801.1354549816097;8104.878426823602;8457.53483558404;8466.153384661531;8628.525431101303;8647.308215342773;8386.496810191393;8596.785080372994;8610.87083693745;8618;8623.956880215606;1969.2221572478861;2168.273628334502;2268.6483595042796;2300.252417964164;2323.384303159664;2251.8986645600903;2254.289898681918;2254.3687767425067;2257.16484900587;2258.6499092640665;2259.559385919746;2260.2315212827634;2296.7243930728337;2298.9655155172686;2303.8272129590264;1936.3319654719098;2005.8896760678158;2133.8186254168413;2186.6719992001167;2195.9121635134575;2225.3991422316044;2231.364061242538;2236.474428509299;2250.0437314141586;2253.110021541498;8387.412881098326;8387.454815437039;8442.282405995498;8479.872801907977;8485.193906578865;4931.112399768041;5058;5059.671121377099;5063.164577844651;5065.442801291855;2943.3377490064777;3053.16809914052;3101.069679096262;3106.176863131272;3132.9530057049164;996.3473924579412;1014.2747935226275;1030.701096681969;1045.6653870761284;1061.8354155105972;11568.363739994296;11574.826377604342;11589.072874170046;11635.069194464422;11640.883591164065;4409.536998615164;4414.404055452537;4451.910961780746;4494.37078808967;4524.47968483622;9930.80138397228;9946.353487023465;9961;9972.401655900669;9990.900090999143;5081.085404627129;5081.949180508222;5085.415177254589;5087.440381558025;5101.540861322499;4218.810153543098;4581.496035436099;4734.715917044989;4743.881402964954;4805.735684537384;3806.619338066171;3898.941515877264;3906.0820707133803;3931.410288456754;4010.0977280111742;1210.0863847794858;1239.9788344997596;1246.3954981833986;1246.7132559511363;1272.1985149355846;934.5981228071859;974.7173319737196;982.6364245229311;982.7150126463389;988.5551501824208;5763.942360576424;5799.5650326225705;5822.592418530747;5870.119482077637;5901.40985901415;431.33358960406247;436.6288654643591;438.8332433675247;448.3498926556506;449.69420793859837;3863.208042351311;3933.7443066200603;3957.821898014596;3964.365701487748;4001.6598589119667;10179.440130792878;10288.794224115625;10597.470126493645;10605.204609654307;10606.575736970435;10431.113355364727;10431.791364172674;10504.947475262576;10515.053645171818;10546.472676366151;7993.440459167919;8130.512169269745;8133.877991830127;8152.959235203904;8155.184481551797;5662.405447427961;5697.743601537858;5760.855978600569;5766.654000759968;5843.211166492469;9723;9819.55811988448;9822.312438129262;9826.115649591571;9826.361286516354;9393.530323483661;9680.854787178057;9761.121499065119;9766.267529935425;9781.168600669023;6925.6190909500465;7346.302101300368;7460.253974602496;7492.250774922464;7675.309222170032;8370.665173392996;8423.410361274651;8457.450265732708;8486.872696909675;8489.235968762841;7399;7537.924620753723;7596.544207347356;7604.163542010485;7654.043244594426;7083.489329839012;7108.07595012645;7189.928100718926;7261.854762904607;7321.926780732338;6999.230084690782;7036.894446583203;7080.929190708027;7084.079069720903;7085.256048114874;4860.538248866352;4941.950580494149;5033.874153146201;5070.847874563769;5115.104856650146;5096.949030509648;5113.565346945551;5155.046316431472;5184;5243.397009343822 10:24:33 INFO - PROCESS | 23598 | |4;prototype.html;325.8256832594562;330.1893850596784;335.2574048482612;335.54030977560745;336.53558089836054;5335.893282134355;5367.302250707407;5370.2750128732605;5381.515663590276;5448.673079615226;5350.250964864922;5359.08895487767;5364.490373414529;5366.275552800371;5373.7220295619645;3983.163535657508;3994.940075898864;4132.690048246393;4157.937630935538;4179.686523510733;4091.304478238692;4113.231310536468;4122.154958233555;4133.483314585676;4136.234796562646;3910.237503686782;4089.3865920111925;4102.97948510257;4103.671706263507;4106.8973275668195;3982.9402558961638;4038.131801662642;4042.797860106983;4135.813888375;4150.211459822654;3592.550931133608;3652.561692596879;3676.3015027145025;3678.797666128362;3688.870889518854;5089.735067894789;5128.666636668642;5133.435322114565;5144.176931690949;5192.506711862367;4596.333531637893;4689.132510485537;4713.835015774465;4772.952270477285;4784.325486079879;5441.1838224266285;5468.945310546884;5479;5560.555155587584;5599.832005039855;4059.451973983504;4061.939070913939;4081.3061779497557;4085.346344584882;4087.4861959894747;5617.775288988436;5729.770809167629;5771.336296325892;5779.739911703983;5784.219130417424;4097.2010457961005;4099.344104943195;4123.525794533607;4127.484064491939;4128.979355103205;4157.376393540993;4159.043420013414;4168.458100446923;4175.599030557441;4178.979105104455;4509.549045095464;4696.671233013656;4697.718136911796;4720.9141897363115;4771.642126840431;5504.889902201933;5514.36584792754;5527.50252477279;5554.944450555524;5564.666120032811;1431.4918204037624;1435.1245740098532;1440.1790979141788;1442.689821688321;1443.7112577484545;888.9777755556163;919.6297516700068;944.6976967370375;956.039180623469;974.055166488505;5249.372694464728;5405.540529055074;5420.593455490854;5443.510084092451;5491.505764481136;5695.686737229409;5700.914486282626;5722.341930678025;5743.913841292384;5768.7692492300675;5327.547158491571;5372.811951581676;5405.702686352289;5446.455354464521;5452.154915988028;3035.2850639388676;3046.908592742221;3062.8009179403266;3072.493038648598;3080.7073328033803;5908.675022873697;5913.970430147821;5926.67403292823;5954.910676339859;5958.255218097738;5566.805161819398;5910.083936989773;5919.67441790697;5923.407659234128;5939.584229104008;5938.82183534486;5953.28560572734;5971.462568368867;5990.251218597676;5997.430244126801;5573.219749235192;5761.942380576308;5809.419058094157;5816.854578635568;5849.707514624337;5693.800716974886;5729.570282228933;5739.713014349182;5741.311042674739;5749.338826034892;5881.617694849821;5900.881982360414;5927.436893495111;5961.344252132349;6000.43988562968;4122.793860307032;4143.3784932260405;4147.771872547039;4150.232207041707;4152.875413737593;5722;5789.94210057894;5818.4763371296785;5836.591438599257;5840.707964601838;5569.331680198402;5644.85887852807;5669.31968163823;5698.857528561819;5703.971480142573;5649.209110724584;5677.545796336366;5683.914741278967;5713.285839270091;5719.28508936383;5343.812966546152;5589.161625756169;5600.4959553640365;5605.215269862141;5614.606977511535;5451.473587395536;5618.499767603377;5649.491545760901;5653.886922261449;5681.403452637579;5537.9169312459535;5556.138798486241;5556.471805328485;5589.80435684749;5600.803971860965 10:24:33 INFO - PROCESS | 23598 | |5;yui.html;779.2207792207793;784.3098073695147;799.9080105787837;831.8502669519484;846.284889268568;13618.659533511667;13930.164190148598;14086.366113524891;14086.436542538298;14112.71774564508;15105.244737763123;15113.093214407143;15245.39018439261;15247.77128343073;15253.618659533517;675.4292622733807;796.1998191817245;819.5205804604299;824.044108833753;824.8968878890139;811.6144831205189;822.1080128061061;822.2435359469303;822.9094799572042;823.7858156879224;863.8229163021565;864.6843901975765;867.6789587852503;871.825634873028;872.5113936195751;700.2192555300828;830.983380332396;850.4472093139447;863.365426411587;863.5380071661663;627.8681476889859;628.9245290565116;629.1914889367141;629.4869681209799;629.5152732396075;12381.504739810396;12403.379831008504;12404.379781010914;12434.689132771662;12546.05904557162;12897.548585799546;13336.933045356349;13422.127561708458;13422.731545369135;13439.65603439658;11773.234739741974;11944.761104777856;12024.939875300568;12089.093318001098;12123.454444550016;3817.351050321452;3821.48409964654;3888.747231429948;3951.446797448331;3992.301347264246;71106.25037454297;72124.6393768033;73309;73883.26116738871;74133.62933185353;10991.725206869733;11273;11545.249558778652;11755.647330580096;11836;18817;18853.528661783566;18864.33974810875;18882.527936801416;18917.05414729258;8446.746597602081;8504.872426913602;8565.871511927326;8596.269317108116;8757.47455152693;4824.614030877591;4888.462269150391;4951.653384263067;4959.677620954626;4995.175795993693;3469.965300347015;3603.0271826607195;3611.043073585502;3617.439296908983;3620.113072297304;521.7000224870715;582.6271186440681;588.8910551547978;591.5060924128315;593.7506247376112;507.8248004438463;691.3708525242006;704.2745971649209;705.9823504412328;714.0966677153405;10043.4476103815;10708.250422470352;10801.513931873085;10983.61557345489;11064.889351106547;709.2411120101546;715.7387553542919;716.1656669979416;716.5772194405222;739.5267029101379;4597.103564804898;5023.899522009539;5152.639315247971;5227.895442091213;5352.143657014859;74787.25212747912;100126.49936750269;117943.820561795;118209.40895295469;123686;102792;102896;103069;105090.4745476283;106422;92780.53609732044;93159;93894.53052734556;95933;96950;10011.949940250252;10049.949750251202;10092.747681308027;10219.386836789816;10224.488775561043;52124.21813672874;52441.47558524366;53455.46544534661;53677.7316113417;54499;70941.26058024686;80349;81221.59389203016;81888.59055704683;82767.58616206881;13579;13593.728125437634;13690.247036413093;14033;14283.642908926944;14607.342669579682;14830.703385932005;14964.261926774332;15869.285882135562;16379.262933167798;14482.34829432657;14644.487442939446;14781.331673926572;15054.849451505783;15397.538073857802;13638.61631479798;14460.421583136978;14773.335199915815;15102.697946041237;15152.242387880342;13545.240564908845;13636.79544806809;14061.859381406464;14123.223222722849;14497;10702.785944281226;11125.610603628835;11285.492152852978;11480.194303158789;11697.766044678889;11191.384473854016;12004.2197257178;12011.339376334035;12110.152289339661;12393.256404615751 10:24:33 INFO - PROCESS | 23598 | __end_tp_report 10:24:33 INFO - PROCESS | 23598 | __start_cc_report 10:24:33 INFO - PROCESS | 23598 | _x_x_mozilla_cycle_collect,1028 10:24:33 INFO - PROCESS | 23598 | __end_cc_report 10:24:33 INFO - PROCESS | 23598 | __startTimestamp1464888273242__endTimestamp 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - PROCESS | 23598 | ------- Summary: start ------- 10:24:33 INFO - PROCESS | 23598 | Number of tests: 6 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - PROCESS | 23598 | [#0] dojo.html Cycles:165 Average:5409.29 Median:5632.72 stddev:620.22 (11.0%) stddev-sans-first:595.74 10:24:33 INFO - PROCESS | 23598 | Values: 3128.2 3150.5 3167.3 3188.6 3212.0 5312.7 5374.8 5417.9 5486.4 5515.8 5375.4 5381.7 5391.0 5405.5 5437.1 4795.2 4843.2 5024.7 5075.3 5127.5 5027.1 5075.2 5084.1 5092.7 5096.1 4828.0 4885.8 4925.9 4936.8 4990.3 5023.6 5026.2 5031.6 5033.7 5096.3 4970.2 4998.9 5012.0 5015.0 5016.7 5168.5 5294.1 5338.9 5396.0 5523.4 5794.4 5826.1 5828.2 5915.7 5924.0 5933.4 5949.8 5956.9 5961.7 5966.0 5299.9 5312.2 5367.3 5377.6 5398.4 5938.9 5948.7 5954.3 5958.0 5966.1 5511.8 5723.3 5723.8 5727.7 5731.1 5761.0 5827.2 5832.6 5858.3 5861.2 5813.9 5818.3 5819.7 5826.8 5837.4 5584.3 5661.4 5798.2 5824.9 5844.1 4319.8 4381.3 4394.9 4422.9 4425.9 3915.6 3925.6 3925.8 3953.9 3957.9 5369.2 5413.0 5461.2 5469.4 5477.1 5684.7 5735.8 5742.7 5749.7 5785.5 5422.0 5446.1 5447.6 5459.6 5460.1 4904.5 4933.4 4947.0 4957.8 5006.9 5959.8 6068.5 6069.0 6082.3 6133.9 5898.6 5899.1 5907.0 5907.7 5907.9 5727.0 5975.4 6031.8 6056.8 6062.7 5787.2 5806.5 5812.1 5827.8 5858.3 5869.1 5902.7 5909.3 5910.3 5919.2 5553.4 5677.9 5719.7 5749.3 5762.0 5738.3 5744.7 5750.3 5753.0 5758.2 5658.0 5667.1 5668.6 5670.1 5672.6 5596.1 5635.2 5674.4 5699.5 5799.7 5595.2 5620.6 5622.8 5632.7 5664.8 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - PROCESS | 23598 | [#1] ext.html Cycles:180 Average:59172.44 Median:42310.79 stddev:113614.09 (268.5%) stddev-sans-first:113847.65 10:24:33 INFO - PROCESS | 23598 | Values: 582.9 609.9 610.1 626.6 631.8 31624.8 32273.4 34615.5 34785.5 34791.3 45712.0 46547.5 46691.0 50443.7 50471.7 8646.6 8817.9 8821.7 8832.8 8836.0 8599.0 8737.4 8743.5 8745.7 8747.5 8734.7 8783.2 8786.3 8787.1 8797.8 8657.1 8720.2 8730.6 8732.9 8736.2 8614.6 8709.4 8709.5 8712.9 8714.8 42792.0 43275.4 43342.3 43355.3 43370.6 3335.4 3914.0 4068.6 4121.2 4194.8 32721.2 32890.0 32996.5 33444.5 33616.3 4204.8 4265.7 4275.4 4444.1 4510.7 340841.3 345091.0 345279.0 345776.0 347790.0 52898.0 53092.7 53411.7 53426.5 53452.7 55457.4 62043.4 63629.0 63640.7 68818.7 17298.0 17581.1 17602.9 17604.6 17621.8 13351.3 13595.8 13624.2 13625.7 13633.3 16100.7 16967.5 17373.7 17408.3 17454.3 6684.6 6693.9 6716.7 6794.8 6973.2 930.5 1057.7 1117.3 1151.9 1223.3 32264.2 32579.0 32821.5 33126.8 33335.0 1145.4 1164.3 1193.4 1242.0 1242.3 16869.3 17335.6 17357.5 17467.0 17628.7 521176.0 521252.8 521822.0 522042.0 523890.0 59149.4 59612.4 59614.1 59621.0 59681.4 1259.7 1366.4 1394.0 1396.9 1400.9 32349.8 33620.7 33701.8 34000.3 34248.8 51056.7 51388.5 51561.7 51576.7 51857.2 400498.0 402494.0 402857.0 402980.0 403427.0 32530.0 40921.6 41521.6 45088.8 45190.1 47662.8 47971.3 48630.5 48753.3 49254.8 41628.2 42316.6 42444.4 42575.0 42744.4 41282.2 41571.6 41826.8 41901.6 42305.0 40925.0 41661.4 42740.6 42772.6 42818.0 35338.6 36519.5 36698.3 37270.6 37556.0 28083.7 28213.9 28547.0 28572.3 28685.1 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - PROCESS | 23598 | [#2] jquery.html Cycles:180 Average:27442.46 Median:23175.59 stddev:76795.04 (331.4%) stddev-sans-first:76983.60 10:24:33 INFO - PROCESS | 23598 | Values: 384.7 384.8 397.6 400.3 414.1 14210.6 16650.8 18265.8 19763.2 19794.4 19042.3 19214.6 19312.9 19804.7 19820.2 5444.9 5543.8 5588.1 5588.1 5589.4 4057.2 5389.2 5568.1 5582.4 5998.3 6242.0 6334.5 6346.8 6356.3 6361.2 6102.5 6268.2 6325.7 6342.9 6346.2 5499.8 5504.0 5518.6 5525.7 5531.6 22381.7 22948.9 23402.3 23664.4 23692.2 2384.4 2386.2 2403.0 2482.2 2487.0 13868.0 14120.7 14121.2 14467.6 14879.4 1850.5 1882.8 1914.3 1936.5 1984.0 53039.5 53304.0 70801.6 82694.8 82872.0 10246.5 10692.1 10769.9 10804.2 10903.5 13060.9 13510.9 14501.6 15026.2 15038.8 8584.7 8595.2 8598.4 8709.7 8795.5 8544.3 8604.6 8621.1 8752.6 8765.5 6719.5 6763.4 6823.9 6859.0 6866.8 1884.3 1891.2 1928.8 1938.4 1963.7 976.5 1078.4 1125.3 1128.9 1177.4 19395.8 19897.6 20126.0 20178.4 20227.4 1024.4 1039.3 1042.7 1061.8 1069.0 11020.9 11562.6 11575.7 11586.5 11589.3 461253.0 465188.0 469233.0 474511.0 475221.0 52280.5 52378.0 82128.0 82649.2 84858.6 1053.8 1067.2 1105.4 1131.3 1132.0 17396.6 17493.2 17788.3 17796.8 17857.1 28731.9 37591.2 38204.6 38903.8 39204.0 51961.7 52571.9 53132.2 53899.2 54139.2 8593.2 8735.4 8784.2 8796.1 8920.3 13403.7 13417.6 13482.0 13530.6 13655.9 11692.3 11843.0 12084.4 12137.9 12177.0 11297.3 11431.3 11672.2 11672.8 11972.3 11446.8 11949.2 11951.8 12076.4 12270.8 7461.6 7859.1 8658.3 8859.2 8984.5 11682.8 11684.9 11980.2 12011.0 12170.8 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - PROCESS | 23598 | [#3] mootools.html Cycles:180 Average:5594.03 Median:5064.30 stddev:3193.79 (63.1%) stddev-sans-first:3186.66 10:24:33 INFO - PROCESS | 23598 | Values: 1328.9 1508.9 1533.1 1655.5 1801.1 8104.9 8457.5 8466.2 8628.5 8647.3 8386.5 8596.8 8610.9 8618.0 8624.0 1969.2 2168.3 2268.6 2300.3 2323.4 2251.9 2254.3 2254.4 2257.2 2258.6 2259.6 2260.2 2296.7 2299.0 2303.8 1936.3 2005.9 2133.8 2186.7 2195.9 2225.4 2231.4 2236.5 2250.0 2253.1 8387.4 8387.5 8442.3 8479.9 8485.2 4931.1 5058.0 5059.7 5063.2 5065.4 2943.3 3053.2 3101.1 3106.2 3133.0 996.3 1014.3 1030.7 1045.7 1061.8 11568.4 11574.8 11589.1 11635.1 11640.9 4409.5 4414.4 4451.9 4494.4 4524.5 9930.8 9946.4 9961.0 9972.4 9990.9 5081.1 5081.9 5085.4 5087.4 5101.5 4218.8 4581.5 4734.7 4743.9 4805.7 3806.6 3898.9 3906.1 3931.4 4010.1 1210.1 1240.0 1246.4 1246.7 1272.2 934.6 974.7 982.6 982.7 988.6 5763.9 5799.6 5822.6 5870.1 5901.4 431.3 436.6 438.8 448.3 449.7 3863.2 3933.7 3957.8 3964.4 4001.7 10179.4 10288.8 10597.5 10605.2 10606.6 10431.1 10431.8 10504.9 10515.1 10546.5 7993.4 8130.5 8133.9 8153.0 8155.2 5662.4 5697.7 5760.9 5766.7 5843.2 9723.0 9819.6 9822.3 9826.1 9826.4 9393.5 9680.9 9761.1 9766.3 9781.2 6925.6 7346.3 7460.3 7492.3 7675.3 8370.7 8423.4 8457.5 8486.9 8489.2 7399.0 7537.9 7596.5 7604.2 7654.0 7083.5 7108.1 7189.9 7261.9 7321.9 6999.2 7036.9 7080.9 7084.1 7085.3 4860.5 4942.0 5033.9 5070.8 5115.1 5096.9 5113.6 5155.0 5184.0 5243.4 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - PROCESS | 23598 | [#4] prototype.html Cycles:180 Average:4719.69 Median:5430.89 stddev:1395.61 (25.7%) stddev-sans-first:1360.00 10:24:33 INFO - PROCESS | 23598 | Values: 325.8 330.2 335.3 335.5 336.5 5335.9 5367.3 5370.3 5381.5 5448.7 5350.3 5359.1 5364.5 5366.3 5373.7 3983.2 3994.9 4132.7 4157.9 4179.7 4091.3 4113.2 4122.2 4133.5 4136.2 3910.2 4089.4 4103.0 4103.7 4106.9 3982.9 4038.1 4042.8 4135.8 4150.2 3592.6 3652.6 3676.3 3678.8 3688.9 5089.7 5128.7 5133.4 5144.2 5192.5 4596.3 4689.1 4713.8 4773.0 4784.3 5441.2 5468.9 5479.0 5560.6 5599.8 4059.5 4061.9 4081.3 4085.3 4087.5 5617.8 5729.8 5771.3 5779.7 5784.2 4097.2 4099.3 4123.5 4127.5 4129.0 4157.4 4159.0 4168.5 4175.6 4179.0 4509.5 4696.7 4697.7 4720.9 4771.6 5504.9 5514.4 5527.5 5554.9 5564.7 1431.5 1435.1 1440.2 1442.7 1443.7 889.0 919.6 944.7 956.0 974.1 5249.4 5405.5 5420.6 5443.5 5491.5 5695.7 5700.9 5722.3 5743.9 5768.8 5327.5 5372.8 5405.7 5446.5 5452.2 3035.3 3046.9 3062.8 3072.5 3080.7 5908.7 5914.0 5926.7 5954.9 5958.3 5566.8 5910.1 5919.7 5923.4 5939.6 5938.8 5953.3 5971.5 5990.3 5997.4 5573.2 5761.9 5809.4 5816.9 5849.7 5693.8 5729.6 5739.7 5741.3 5749.3 5881.6 5900.9 5927.4 5961.3 6000.4 4122.8 4143.4 4147.8 4150.2 4152.9 5722.0 5789.9 5818.5 5836.6 5840.7 5569.3 5644.9 5669.3 5698.9 5704.0 5649.2 5677.5 5683.9 5713.3 5719.3 5343.8 5589.2 5600.5 5605.2 5614.6 5451.5 5618.5 5649.5 5653.9 5681.4 5537.9 5556.1 5556.5 5589.8 5600.8 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - PROCESS | 23598 | [#5] yui.html Cycles:180 Average:21049.68 Median:3607.04 stddev:30430.41 (843.6%) stddev-sans-first:30477.71 10:24:33 INFO - PROCESS | 23598 | Values: 779.2 784.3 799.9 831.9 846.3 13618.7 13930.2 14086.4 14086.4 14112.7 15105.2 15113.1 15245.4 15247.8 15253.6 675.4 796.2 819.5 824.0 824.9 811.6 822.1 822.2 822.9 823.8 863.8 864.7 867.7 871.8 872.5 700.2 831.0 850.4 863.4 863.5 627.9 628.9 629.2 629.5 629.5 12381.5 12403.4 12404.4 12434.7 12546.1 12897.5 13336.9 13422.1 13422.7 13439.7 11773.2 11944.8 12024.9 12089.1 12123.5 3817.4 3821.5 3888.7 3951.4 3992.3 71106.3 72124.6 73309.0 73883.3 74133.6 10991.7 11273.0 11545.2 11755.6 11836.0 18817.0 18853.5 18864.3 18882.5 18917.1 8446.7 8504.9 8565.9 8596.3 8757.5 4824.6 4888.5 4951.7 4959.7 4995.2 3470.0 3603.0 3611.0 3617.4 3620.1 521.7 582.6 588.9 591.5 593.8 507.8 691.4 704.3 706.0 714.1 10043.4 10708.3 10801.5 10983.6 11064.9 709.2 715.7 716.2 716.6 739.5 4597.1 5023.9 5152.6 5227.9 5352.1 74787.3 100126.5 117943.8 118209.4 123686.0 102792.0 102896.0 103069.0 105090.5 106422.0 92780.5 93159.0 93894.5 95933.0 96950.0 10011.9 10049.9 10092.7 10219.4 10224.5 52124.2 52441.5 53455.5 53677.7 54499.0 70941.3 80349.0 81221.6 81888.6 82767.6 13579.0 13593.7 13690.2 14033.0 14283.6 14607.3 14830.7 14964.3 15869.3 16379.3 14482.3 14644.5 14781.3 15054.8 15397.5 13638.6 14460.4 14773.3 15102.7 15152.2 13545.2 13636.8 14061.9 14123.2 14497.0 10702.8 11125.6 11285.5 11480.2 11697.8 11191.4 12004.2 12011.3 12110.2 12393.3 10:24:33 INFO - PROCESS | 23598 | -------- Summary: end -------- 10:24:33 INFO - PROCESS | 23598 | 10:24:33 INFO - TEST-INFO | 23598: exit 0 10:24:33 INFO - TEST-OK | dromaeo_css | took 1112516ms 10:24:33 INFO - TEST-START | kraken 10:24:33 INFO - operating with platform_type : linux_ 10:24:33 INFO - Initialising browser for kraken test... 10:24:33 INFO - TEST-INFO | started process 23781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZPKxqI/profile http://localhost:57781/getInfo.html) 10:24:37 INFO - PROCESS | 23781 | __metrics Screen width/height:1600/1200 10:24:37 INFO - PROCESS | 23781 | colorDepth:24 10:24:37 INFO - PROCESS | 23781 | Browser inner width/height: 1024/697 10:24:37 INFO - PROCESS | 23781 | __metrics 10:24:38 ERROR - PROCESS | 23781 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:24:39 INFO - TEST-INFO | 23781: exit 0 10:24:39 INFO - Browser initialized. 10:24:39 INFO - Running cycle 1/1 for kraken test... 10:24:39 INFO - TEST-INFO | started process 23865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZPKxqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:51 INFO - PROCESS | 23865 | RSS: Main: 156172288 10:24:51 INFO - PROCESS | 23865 | 10:24:53 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57781/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:54 INFO - PROCESS | 23865 | RSS: Main: 214392832 10:24:54 INFO - PROCESS | 23865 | 10:24:57 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57781/tests/kraken/driver.html?testName=audio-dft) 10:24:57 INFO - PROCESS | 23865 | RSS: Main: 200994816 10:24:57 INFO - PROCESS | 23865 | 10:25:01 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57781/tests/kraken/driver.html?testName=audio-fft) 10:25:01 INFO - PROCESS | 23865 | RSS: Main: 268464128 10:25:01 INFO - PROCESS | 23865 | 10:25:03 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57781/tests/kraken/driver.html?testName=audio-oscillator) 10:25:04 INFO - PROCESS | 23865 | RSS: Main: 179191808 10:25:04 INFO - PROCESS | 23865 | 10:25:06 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57781/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:07 INFO - PROCESS | 23865 | RSS: Main: 183304192 10:25:07 INFO - PROCESS | 23865 | 10:25:10 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57781/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:10 INFO - PROCESS | 23865 | RSS: Main: 219455488 10:25:10 INFO - PROCESS | 23865 | 10:25:14 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57781/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:14 INFO - PROCESS | 23865 | RSS: Main: 220020736 10:25:14 INFO - PROCESS | 23865 | 10:25:17 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57781/tests/kraken/driver.html?testName=json-parse-financial) 10:25:18 INFO - PROCESS | 23865 | RSS: Main: 220565504 10:25:18 INFO - PROCESS | 23865 | 10:25:19 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57781/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:20 INFO - PROCESS | 23865 | RSS: Main: 205737984 10:25:20 INFO - PROCESS | 23865 | 10:25:22 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57781/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:22 INFO - PROCESS | 23865 | RSS: Main: 210018304 10:25:22 INFO - PROCESS | 23865 | 10:25:24 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57781/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:25 INFO - PROCESS | 23865 | RSS: Main: 215502848 10:25:25 INFO - PROCESS | 23865 | 10:25:27 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:28 INFO - PROCESS | 23865 | RSS: Main: 221851648 10:25:28 INFO - PROCESS | 23865 | 10:25:31 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:31 INFO - PROCESS | 23865 | RSS: Main: 220131328 10:25:31 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | Cycle 1(1): loaded http://localhost:57781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57781/tests/kraken/driver.html?testName=ai-astar) 10:25:33 INFO - PROCESS | 23865 | RSS: Main: 262778880 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | __start_tp_report 10:25:33 INFO - PROCESS | 23865 | _x_x_mozilla_page_load 10:25:33 INFO - PROCESS | 23865 | _x_x_mozilla_page_load_details 10:25:33 INFO - PROCESS | 23865 | |i|pagename|runs| 10:25:33 INFO - PROCESS | 23865 | |0;ai-astar;112;106;111;111;111;111;109;111;112;110 10:25:33 INFO - PROCESS | 23865 | |1;audio-beat-detection;155;126;129;189;126;126;152;130;162;125 10:25:33 INFO - PROCESS | 23865 | |2;audio-dft;159;161;160;161;161;160;161;161;160;161 10:25:33 INFO - PROCESS | 23865 | |3;audio-fft;75;74;75;135;76;76;75;75;110;74 10:25:33 INFO - PROCESS | 23865 | |4;audio-oscillator;82;84;120;83;84;84;127;84;85;131 10:25:33 INFO - PROCESS | 23865 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;117;116 10:25:33 INFO - PROCESS | 23865 | |6;imaging-darkroom;146;146;146;148;147;146;146;146;146;145 10:25:33 INFO - PROCESS | 23865 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 10:25:33 INFO - PROCESS | 23865 | |8;json-parse-financial;53;61;56;53;55;53;55;53;54;53 10:25:33 INFO - PROCESS | 23865 | |9;json-stringify-tinderbox;62;62;62;62;62;62;61;62;66;61 10:25:33 INFO - PROCESS | 23865 | |10;stanford-crypto-aes;80;79;84;81;83;80;80;83;110;86 10:25:33 INFO - PROCESS | 23865 | |11;stanford-crypto-ccm;132;121;134;137;119;120;129;125;122;133 10:25:33 INFO - PROCESS | 23865 | |12;stanford-crypto-pbkdf2;165;167;164;159;159;168;158;163;161;158 10:25:33 INFO - PROCESS | 23865 | |13;stanford-crypto-sha256-iterative;62;65;63;61;62;62;63;66;64;60 10:25:33 INFO - PROCESS | 23865 | __end_tp_report 10:25:33 INFO - PROCESS | 23865 | __start_cc_report 10:25:33 INFO - PROCESS | 23865 | _x_x_mozilla_cycle_collect,1615 10:25:33 INFO - PROCESS | 23865 | __end_cc_report 10:25:33 INFO - PROCESS | 23865 | __startTimestamp1464888333743__endTimestamp 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | ------- Summary: start ------- 10:25:33 INFO - PROCESS | 23865 | Number of tests: 14 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:1.79 10:25:33 INFO - PROCESS | 23865 | Values: 112.0 106.0 111.0 111.0 111.0 111.0 109.0 111.0 112.0 110.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:141.00 stddev:21.73 (15.4%) stddev-sans-first:22.53 10:25:33 INFO - PROCESS | 23865 | Values: 155.0 126.0 129.0 189.0 126.0 126.0 152.0 130.0 162.0 125.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.71 (0.4%) stddev-sans-first:0.50 10:25:33 INFO - PROCESS | 23865 | Values: 159.0 161.0 160.0 161.0 161.0 160.0 161.0 161.0 160.0 161.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#3] audio-fft Cycles:10 Average:84.50 Median:75.00 stddev:20.89 (27.8%) stddev-sans-first:21.87 10:25:33 INFO - PROCESS | 23865 | Values: 75.0 74.0 75.0 135.0 76.0 76.0 75.0 75.0 110.0 74.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.00 stddev:20.61 (24.5%) stddev-sans-first:21.19 10:25:33 INFO - PROCESS | 23865 | Values: 82.0 84.0 120.0 83.0 84.0 84.0 127.0 84.0 85.0 131.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:25:33 INFO - PROCESS | 23865 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:25:33 INFO - PROCESS | 23865 | Values: 146.0 146.0 146.0 148.0 147.0 146.0 146.0 146.0 146.0 145.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:25:33 INFO - PROCESS | 23865 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:2.50 (4.6%) stddev-sans-first:2.59 10:25:33 INFO - PROCESS | 23865 | Values: 53.0 61.0 56.0 53.0 55.0 53.0 55.0 53.0 54.0 53.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.40 (2.3%) stddev-sans-first:1.48 10:25:33 INFO - PROCESS | 23865 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 66.0 61.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:82.00 stddev:9.19 (11.2%) stddev-sans-first:9.60 10:25:33 INFO - PROCESS | 23865 | Values: 80.0 79.0 84.0 81.0 83.0 80.0 80.0 83.0 110.0 86.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:130.50 stddev:6.60 (5.1%) stddev-sans-first:6.76 10:25:33 INFO - PROCESS | 23865 | Values: 132.0 121.0 134.0 137.0 119.0 120.0 129.0 125.0 122.0 133.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.50 stddev:3.74 (2.3%) stddev-sans-first:3.82 10:25:33 INFO - PROCESS | 23865 | Values: 165.0 167.0 164.0 159.0 159.0 168.0 158.0 163.0 161.0 158.0 10:25:33 INFO - PROCESS | 23865 | 10:25:33 INFO - PROCESS | 23865 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.81 (2.9%) stddev-sans-first:1.90 10:25:33 INFO - PROCESS | 23865 | Values: 62.0 65.0 63.0 61.0 62.0 62.0 63.0 66.0 64.0 60.0 10:25:33 INFO - PROCESS | 23865 | -------- Summary: end -------- 10:25:33 INFO - PROCESS | 23865 | 10:25:34 INFO - TEST-INFO | 23865: exit 0 10:25:34 INFO - TEST-OK | kraken | took 60751ms 10:25:34 INFO - SUITE-END | took 1173s 10:25:34 INFO - Completed test suite (00:19:33) 10:25:34 INFO - javascript benchmark 10:25:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.249220187155, 3150.54317124017, 3167.3190264093214, 3188.5536024956523, 3211.9839400802994, 5312.654677445963, 5374.811881584145, 5417.918731219025, 5486.3690675572325, 5515.806946756859, 5375.408705042442, 5381.67709937404, 5391.002664507059, 5405.5135037846585, 5437.13005919053, 4795.184818580841, 4843.200871856157, 5024.723640199788, 5075.289459475676, 5127.461616530267, 5027.069992051483, 5075.162598171298, 5084.13569693153, 5092.694438333693, 5096.108181068298, 4828.0, 4885.804567817283, 4925.876853078666, 4936.777844996984, 4990.326305948687, 5023.6232282578585, 5026.170681837492, 5031.622628302892, 5033.672811267256, 5096.286519887219, 4970.204767237261, 4998.850034498971, 5012.047710934947, 5014.974925125388, 5016.724080175589, 5168.53483186515, 5294.100002999499, 5338.893222135574, 5396.028714831329, 5523.4200408956885, 5794.420557944214, 5826.096954971986, 5828.2131912191735, 5915.674637894914, 5924.022536281508, 5933.376995415462, 5949.821505354803, 5956.880862382728, 5961.672108034057, 5966.0, 5299.920501192485, 5312.203169524563, 5367.275417818583, 5377.623566350318, 5398.352197736297, 5938.940610593839, 5948.7323070461935, 5954.345022047572, 5958.046712525975, 5966.105084237399, 5511.834644960658, 5723.284589426322, 5723.771049157987, 5727.656340619576, 5731.111677689964, 5760.991826430358, 5827.213326200994, 5832.591718579743, 5858.2677165354335, 5861.1501332307425, 5813.854653633608, 5818.301803783573, 5819.6508209507565, 5826.825195244065, 5837.357890632027, 5584.274044374205, 5661.405552416937, 5798.159266906275, 5824.883502330014, 5844.094165404369, 4319.827206911751, 4381.342798580238, 4394.934075988863, 4422.911541769211, 4425.911481770411, 3915.6084391560616, 3925.568187499373, 3925.764454132704, 3953.920921581552, 3957.920841583152, 5369.24830523727, 5413.02565538199, 5461.1808228766, 5469.398366179717, 5477.096279113902, 5684.6589204647025, 5735.799247026417, 5742.712864356849, 5749.655020698771, 5785.537157027512, 5422.0, 5446.101393270066, 5447.591430642718, 5459.5632349412745, 5460.126379779216, 4904.509549045139, 4933.358663373739, 4946.950530494721, 4957.7769000395065, 5006.89986200274, 5959.821205363846, 6068.4538391544975, 6069.02895536712, 6082.300535438393, 6133.938660613426, 5898.587098903035, 5899.085641725539, 5906.970465147647, 5907.675077870758, 5907.940920590739, 5726.997775389207, 5975.37258587842, 6031.849203769941, 6056.848578785565, 6062.7271772769445, 5787.189793429007, 5806.477417032487, 5812.128180772918, 5827.79602713903, 5858.2677165354335, 5869.119632055226, 5902.675352855634, 5909.261342332208, 5910.261217347832, 5919.171316015675, 5553.416891226363, 5677.858053548694, 5719.656820590778, 5749.252597162342, 5762.0, 5738.254026976467, 5744.684042377542, 5750.30996280449, 5753.0, 5758.1650660654805, 5657.971710141423, 5667.093265077568, 5668.631538949955, 5670.09278515452, 5672.574556908331, 5596.076647353141, 5635.154726791015, 5674.432556744293, 5699.544036477155, 5799.681017544076, 5595.160725891149, 5620.550355971594, 5622.803201887914, 5632.718364081861, 5664.801731939362], "value": 5367.215630823545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.9067349224123, 609.8841220168168, 610.0787810406288, 626.6208943589131, 631.7946667333118, 31624.84187579062, 32273.35453290933, 34615.480767788504, 34785.478217826756, 34791.304173916506, 45712.0, 46547.534524654744, 46690.99999999991, 50443.74778126113, 50471.74764126174, 8646.610902509387, 8817.911820881773, 8821.73534793954, 8832.779180520474, 8835.95582022089, 8598.957005214965, 8737.388382813206, 8743.475391476532, 8745.737627871174, 8747.475151490931, 8734.737957861242, 8783.209511143996, 8786.341024423162, 8787.077356877531, 8797.780055498632, 8657.091005444432, 8720.171583699539, 8730.607122679494, 8732.912670873306, 8736.170063843925, 8614.612342444605, 8709.432302185603, 8709.520976346299, 8712.912870871274, 8714.825703485958, 42792.0, 43275.350869736976, 43342.34986475174, 43355.34966975498, 43370.56629433697, 3335.449650807614, 3913.960860391388, 4068.6338229559483, 4121.196366708493, 4194.832206711759, 32721.181970450692, 32890.0, 32996.50505242423, 33444.49833252503, 33616.32767344664, 4204.831806727727, 4265.7440553566885, 4275.422817919603, 4444.133393988173, 4510.684252102355, 340841.2957935219, 345091.0, 345279.0, 345776.0, 347790.0, 52898.0, 53092.73453632707, 53411.732941335045, 53426.46573534293, 53452.73273633607, 55457.44542554604, 62043.37956620376, 63629.0, 63640.68179659072, 68818.65590672015, 17297.962122272704, 17581.120943952752, 17602.91198543999, 17604.559886002953, 17621.823781762017, 13351.265680387673, 13595.796063059062, 13624.18254904709, 13625.659358515919, 13633.318334083257, 16100.677986440205, 16967.49097527076, 17373.7393939091, 17408.303667853143, 17454.301827926996, 6684.598924064571, 6693.933060669428, 6716.671327553896, 6794.830129246809, 6973.19808222061, 930.4556834251903, 1057.6509751781894, 1117.2570240789785, 1151.8675352334421, 1223.2721530689225, 32264.19339516484, 32579.0, 32821.507677384856, 33126.834365828014, 33335.0, 1145.3643228008534, 1164.2665120973902, 1193.3794426897964, 1242.0498318786135, 1242.2732701369619, 16869.32522699103, 17335.56661083483, 17357.47927562175, 17467.0, 17628.735568966476, 521176.0, 521252.7561535328, 521822.0, 522042.0, 523890.0, 59149.40850591525, 59612.403875960685, 59614.10578841321, 59621.0, 59681.403185968455, 1259.741752940645, 1366.3782978744648, 1393.979090313646, 1396.8533304002933, 1400.9369578368999, 32349.838250808596, 33620.663793362735, 33701.831490842385, 34000.31999360048, 34248.82875585606, 51056.744716277666, 51388.48611513837, 51561.71095722487, 51576.74211628918, 51857.22214166866, 400498.0, 402494.0, 402857.0, 402980.0, 403427.0, 32530.0, 40921.59078409178, 41521.584784151775, 45088.774556127006, 45190.09619807651, 47662.76168619135, 47971.280430794264, 48630.513694864014, 48753.2687009688, 49254.75372623114, 41628.1674366517, 42316.576834231266, 42444.36333454939, 42575.0, 42744.35883461813, 41282.1743565133, 41571.58428415677, 41826.79086604548, 41901.580984189764, 42305.0, 40925.0, 41661.37507937444, 42740.57259427366, 42772.57227427811, 42818.0, 35338.646613533536, 36519.45220821743, 36698.26603467969, 37270.6272937278, 37556.0, 28083.71916280811, 28213.858930705213, 28547.0, 28572.285692857844, 28685.139445816658], "value": 20370.69864064104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.67494966753094, 384.76529317116535, 397.6302039103636, 400.3014739279956, 414.09107010112797, 14210.644733881658, 16650.750238746397, 18265.817341826594, 19763.209471621136, 19794.406167814952, 19042.33351832686, 19214.615707685836, 19312.903435482836, 19804.70292945607, 19820.20719171235, 5444.863878403042, 5543.805966791163, 5588.105903055512, 5588.105903055512, 5589.357223919261, 4057.229126465962, 5389.191621256804, 5568.136938774496, 5582.413846546115, 5998.25021872266, 6242.0, 6334.461570766491, 6346.84132896679, 6356.269029061647, 6361.2048493938255, 6102.511799056065, 6268.15379923709, 6325.746970121189, 6342.936570634304, 6346.2067241594805, 5499.790046189872, 5503.972480137613, 5518.558515318765, 5525.723713814334, 5531.612787104904, 22381.664275035888, 22948.885255573783, 23402.297931062094, 23664.40838979022, 23692.170774022827, 2384.3562238195764, 2386.176769014687, 2403.038784486202, 2482.1808803095114, 2487.0176280369333, 13868.0, 14120.717585648332, 14121.223332716696, 14467.638309042253, 14879.404823807035, 1850.463365623981, 1882.7552418185685, 1914.301280032778, 1936.5158710322419, 1984.0, 53039.46960530384, 53304.0, 70801.6459917697, 82694.75957860576, 82872.0, 10246.53890574926, 10692.144628429707, 10769.88430495524, 10804.24370294072, 10903.454827258605, 13060.869391306156, 13510.932445337907, 14501.564953051426, 15026.17356045406, 15038.849611503963, 8584.74245772628, 8595.18345757152, 8598.441101328393, 8709.695160669346, 8795.51624660637, 8544.273736732448, 8604.612792424356, 8621.094785047606, 8752.606132724042, 8765.517896515752, 6719.462443004548, 6763.357481039294, 6823.897641535381, 6858.965705171442, 6866.793996180123, 1884.3310624728024, 1891.215145714513, 1928.758905136858, 1938.4184744576853, 1963.7447131872766, 976.5215044628081, 1078.412265315405, 1125.2517076144436, 1128.915331350152, 1177.3583397048628, 19395.806041939682, 19897.60204795896, 20126.0, 20178.394648160578, 20227.39317820468, 1024.3700124423574, 1039.3348257115451, 1042.718466014172, 1061.792950374685, 1069.0, 11020.889791101987, 11562.595309164139, 11575.710607234887, 11586.47860846264, 11589.304641721523, 461253.0, 465188.0, 469233.0, 474511.0, 475221.0, 52280.47719522832, 52378.0, 82127.9999999988, 82649.17350826415, 84858.57570712107, 1053.8419237114495, 1067.2262609607972, 1105.4196546812987, 1131.3494740524231, 1131.9547218111347, 17396.565085872953, 17493.212805424042, 17788.288468461116, 17796.822031779517, 17857.107144642974, 28731.856340718998, 37591.2481750358, 38204.6179538201, 38903.83288501349, 39204.0, 51961.7401912988, 52571.9485610278, 53132.20301695555, 53899.191512128134, 54139.18791218056, 8593.183647553473, 8735.432196907435, 8784.209421152127, 8796.120387961153, 8920.330975177018, 13403.664908377368, 13417.597472075853, 13482.0, 13530.594082177551, 13655.86344136546, 11692.326071050205, 11843.0, 12084.39578021113, 12137.939310303393, 12176.964957978671, 11297.26567773092, 11431.256968297033, 11672.182947193614, 11672.824907626562, 11972.281663100242, 11446.828297575377, 11949.163558550817, 11951.760964780482, 12076.396180191132, 12270.815937760763, 7461.552306861606, 7859.056913170228, 8658.307335413027, 8859.158379953895, 8984.505852178192, 11682.824757628472, 11684.88315116872, 11980.221285616408, 12011.0, 12170.817437738619], "value": 9353.626940843851, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.9069765116446, 1508.8566586174309, 1533.087812751413, 1655.4867990922814, 1801.1354549816097, 8104.878426823602, 8457.53483558404, 8466.153384661531, 8628.525431101303, 8647.308215342773, 8386.496810191393, 8596.785080372994, 8610.87083693745, 8618.0, 8623.956880215606, 1969.2221572478861, 2168.273628334502, 2268.6483595042796, 2300.252417964164, 2323.384303159664, 2251.8986645600903, 2254.289898681918, 2254.3687767425067, 2257.16484900587, 2258.6499092640665, 2259.559385919746, 2260.2315212827634, 2296.7243930728337, 2298.9655155172686, 2303.8272129590264, 1936.3319654719098, 2005.8896760678158, 2133.8186254168413, 2186.6719992001167, 2195.9121635134575, 2225.3991422316044, 2231.364061242538, 2236.474428509299, 2250.0437314141586, 2253.110021541498, 8387.412881098326, 8387.454815437039, 8442.282405995498, 8479.872801907977, 8485.193906578865, 4931.112399768041, 5058.0, 5059.671121377099, 5063.164577844651, 5065.442801291855, 2943.3377490064777, 3053.16809914052, 3101.069679096262, 3106.176863131272, 3132.9530057049164, 996.3473924579412, 1014.2747935226275, 1030.701096681969, 1045.6653870761284, 1061.8354155105972, 11568.363739994296, 11574.826377604342, 11589.072874170046, 11635.069194464422, 11640.883591164065, 4409.536998615164, 4414.404055452537, 4451.910961780746, 4494.37078808967, 4524.47968483622, 9930.80138397228, 9946.353487023465, 9961.0, 9972.401655900669, 9990.900090999143, 5081.085404627129, 5081.949180508222, 5085.415177254589, 5087.440381558025, 5101.540861322499, 4218.810153543098, 4581.496035436099, 4734.715917044989, 4743.881402964954, 4805.735684537384, 3806.619338066171, 3898.941515877264, 3906.0820707133803, 3931.410288456754, 4010.0977280111742, 1210.0863847794858, 1239.9788344997596, 1246.3954981833986, 1246.7132559511363, 1272.1985149355846, 934.5981228071859, 974.7173319737196, 982.6364245229311, 982.7150126463389, 988.5551501824208, 5763.942360576424, 5799.5650326225705, 5822.592418530747, 5870.119482077637, 5901.40985901415, 431.33358960406247, 436.6288654643591, 438.8332433675247, 448.3498926556506, 449.69420793859837, 3863.208042351311, 3933.7443066200603, 3957.821898014596, 3964.365701487748, 4001.6598589119667, 10179.440130792878, 10288.794224115625, 10597.470126493645, 10605.204609654307, 10606.575736970435, 10431.113355364727, 10431.791364172674, 10504.947475262576, 10515.053645171818, 10546.472676366151, 7993.440459167919, 8130.512169269745, 8133.877991830127, 8152.959235203904, 8155.184481551797, 5662.405447427961, 5697.743601537858, 5760.855978600569, 5766.654000759968, 5843.211166492469, 9723.0, 9819.55811988448, 9822.312438129262, 9826.115649591571, 9826.361286516354, 9393.530323483661, 9680.854787178057, 9761.121499065119, 9766.267529935425, 9781.168600669023, 6925.6190909500465, 7346.302101300368, 7460.253974602496, 7492.250774922464, 7675.309222170032, 8370.665173392996, 8423.410361274651, 8457.450265732708, 8486.872696909675, 8489.235968762841, 7399.0, 7537.924620753723, 7596.544207347356, 7604.163542010485, 7654.043244594426, 7083.489329839012, 7108.07595012645, 7189.928100718926, 7261.854762904607, 7321.926780732338, 6999.230084690782, 7036.894446583203, 7080.929190708027, 7084.079069720903, 7085.256048114874, 4860.538248866352, 4941.950580494149, 5033.874153146201, 5070.847874563769, 5115.104856650146, 5096.949030509648, 5113.565346945551, 5155.046316431472, 5184.0, 5243.397009343822], "value": 4396.0556176264945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.8256832594562, 330.1893850596784, 335.2574048482612, 335.54030977560745, 336.53558089836054, 5335.893282134355, 5367.302250707407, 5370.2750128732605, 5381.515663590276, 5448.673079615226, 5350.250964864922, 5359.08895487767, 5364.490373414529, 5366.275552800371, 5373.7220295619645, 3983.163535657508, 3994.940075898864, 4132.690048246393, 4157.937630935538, 4179.686523510733, 4091.304478238692, 4113.231310536468, 4122.154958233555, 4133.483314585676, 4136.234796562646, 3910.237503686782, 4089.3865920111925, 4102.97948510257, 4103.671706263507, 4106.8973275668195, 3982.9402558961638, 4038.131801662642, 4042.797860106983, 4135.813888375, 4150.211459822654, 3592.550931133608, 3652.561692596879, 3676.3015027145025, 3678.797666128362, 3688.870889518854, 5089.735067894789, 5128.666636668642, 5133.435322114565, 5144.176931690949, 5192.506711862367, 4596.333531637893, 4689.132510485537, 4713.835015774465, 4772.952270477285, 4784.325486079879, 5441.1838224266285, 5468.945310546884, 5479.0, 5560.555155587584, 5599.832005039855, 4059.451973983504, 4061.939070913939, 4081.3061779497557, 4085.346344584882, 4087.4861959894747, 5617.775288988436, 5729.770809167629, 5771.336296325892, 5779.739911703983, 5784.219130417424, 4097.2010457961005, 4099.344104943195, 4123.525794533607, 4127.484064491939, 4128.979355103205, 4157.376393540993, 4159.043420013414, 4168.458100446923, 4175.599030557441, 4178.979105104455, 4509.549045095464, 4696.671233013656, 4697.718136911796, 4720.9141897363115, 4771.642126840431, 5504.889902201933, 5514.36584792754, 5527.50252477279, 5554.944450555524, 5564.666120032811, 1431.4918204037624, 1435.1245740098532, 1440.1790979141788, 1442.689821688321, 1443.7112577484545, 888.9777755556163, 919.6297516700068, 944.6976967370375, 956.039180623469, 974.055166488505, 5249.372694464728, 5405.540529055074, 5420.593455490854, 5443.510084092451, 5491.505764481136, 5695.686737229409, 5700.914486282626, 5722.341930678025, 5743.913841292384, 5768.7692492300675, 5327.547158491571, 5372.811951581676, 5405.702686352289, 5446.455354464521, 5452.154915988028, 3035.2850639388676, 3046.908592742221, 3062.8009179403266, 3072.493038648598, 3080.7073328033803, 5908.675022873697, 5913.970430147821, 5926.67403292823, 5954.910676339859, 5958.255218097738, 5566.805161819398, 5910.083936989773, 5919.67441790697, 5923.407659234128, 5939.584229104008, 5938.82183534486, 5953.28560572734, 5971.462568368867, 5990.251218597676, 5997.430244126801, 5573.219749235192, 5761.942380576308, 5809.419058094157, 5816.854578635568, 5849.707514624337, 5693.800716974886, 5729.570282228933, 5739.713014349182, 5741.311042674739, 5749.338826034892, 5881.617694849821, 5900.881982360414, 5927.436893495111, 5961.344252132349, 6000.43988562968, 4122.793860307032, 4143.3784932260405, 4147.771872547039, 4150.232207041707, 4152.875413737593, 5722.0, 5789.94210057894, 5818.4763371296785, 5836.591438599257, 5840.707964601838, 5569.331680198402, 5644.85887852807, 5669.31968163823, 5698.857528561819, 5703.971480142573, 5649.209110724584, 5677.545796336366, 5683.914741278967, 5713.285839270091, 5719.28508936383, 5343.812966546152, 5589.161625756169, 5600.4959553640365, 5605.215269862141, 5614.606977511535, 5451.473587395536, 5618.499767603377, 5649.491545760901, 5653.886922261449, 5681.403452637579, 5537.9169312459535, 5556.138798486241, 5556.471805328485, 5589.80435684749, 5600.803971860965], "value": 4273.296010619207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.2207792207793, 784.3098073695147, 799.9080105787837, 831.8502669519484, 846.284889268568, 13618.659533511667, 13930.164190148598, 14086.366113524891, 14086.436542538298, 14112.71774564508, 15105.244737763123, 15113.093214407143, 15245.39018439261, 15247.77128343073, 15253.618659533517, 675.4292622733807, 796.1998191817245, 819.5205804604299, 824.044108833753, 824.8968878890139, 811.6144831205189, 822.1080128061061, 822.2435359469303, 822.9094799572042, 823.7858156879224, 863.8229163021565, 864.6843901975765, 867.6789587852503, 871.825634873028, 872.5113936195751, 700.2192555300828, 830.983380332396, 850.4472093139447, 863.365426411587, 863.5380071661663, 627.8681476889859, 628.9245290565116, 629.1914889367141, 629.4869681209799, 629.5152732396075, 12381.504739810396, 12403.379831008504, 12404.379781010914, 12434.689132771662, 12546.05904557162, 12897.548585799546, 13336.933045356349, 13422.127561708458, 13422.731545369135, 13439.65603439658, 11773.234739741974, 11944.761104777856, 12024.939875300568, 12089.093318001098, 12123.454444550016, 3817.351050321452, 3821.48409964654, 3888.747231429948, 3951.446797448331, 3992.301347264246, 71106.25037454297, 72124.6393768033, 73309.0, 73883.26116738871, 74133.62933185353, 10991.725206869733, 11273.0, 11545.249558778652, 11755.647330580096, 11836.0, 18817.0, 18853.528661783566, 18864.33974810875, 18882.527936801416, 18917.05414729258, 8446.746597602081, 8504.872426913602, 8565.871511927326, 8596.269317108116, 8757.47455152693, 4824.614030877591, 4888.462269150391, 4951.653384263067, 4959.677620954626, 4995.175795993693, 3469.965300347015, 3603.0271826607195, 3611.043073585502, 3617.439296908983, 3620.113072297304, 521.7000224870715, 582.6271186440681, 588.8910551547978, 591.5060924128315, 593.7506247376112, 507.8248004438463, 691.3708525242006, 704.2745971649209, 705.9823504412328, 714.0966677153405, 10043.4476103815, 10708.250422470352, 10801.513931873085, 10983.61557345489, 11064.889351106547, 709.2411120101546, 715.7387553542919, 716.1656669979416, 716.5772194405222, 739.5267029101379, 4597.103564804898, 5023.899522009539, 5152.639315247971, 5227.895442091213, 5352.143657014859, 74787.25212747912, 100126.49936750269, 117943.820561795, 118209.40895295469, 123686.0, 102792.0, 102896.0, 103069.0, 105090.4745476283, 106422.0, 92780.53609732044, 93159.0, 93894.53052734556, 95933.0, 96950.0, 10011.949940250252, 10049.949750251202, 10092.747681308027, 10219.386836789816, 10224.488775561043, 52124.21813672874, 52441.47558524366, 53455.46544534661, 53677.7316113417, 54499.0, 70941.26058024686, 80349.0, 81221.59389203016, 81888.59055704683, 82767.58616206881, 13579.0, 13593.728125437634, 13690.247036413093, 14033.0, 14283.642908926944, 14607.342669579682, 14830.703385932005, 14964.261926774332, 15869.285882135562, 16379.262933167798, 14482.34829432657, 14644.487442939446, 14781.331673926572, 15054.849451505783, 15397.538073857802, 13638.61631479798, 14460.421583136978, 14773.335199915815, 15102.697946041237, 15152.242387880342, 13545.240564908845, 13636.79544806809, 14061.859381406464, 14123.223222722849, 14497.0, 10702.785944281226, 11125.610603628835, 11285.492152852978, 11480.194303158789, 11697.766044678889, 11191.384473854016, 12004.2197257178, 12011.339376334035, 12110.152289339661, 12393.256404615751], "value": 7611.974264346489, "unit": "score"}], "name": "dromaeo_css", "value": 7258.567772291938, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 111.0, 111.0, 111.0, 109.0, 111.0, 112.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 129.0, 189.0, 126.0, 126.0, 152.0, 130.0, 162.0, 125.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 135.0, 76.0, 76.0, 75.0, 75.0, 110.0, 74.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 120.0, 83.0, 84.0, 84.0, 127.0, 84.0, 85.0, 131.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 61.0, 56.0, 53.0, 55.0, 53.0, 55.0, 53.0, 54.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 66.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 84.0, 81.0, 83.0, 80.0, 80.0, 83.0, 110.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 134.0, 137.0, 119.0, 120.0, 129.0, 125.0, 122.0, 133.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 164.0, 159.0, 159.0, 168.0, 158.0, 163.0, 161.0, 158.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 61.0, 62.0, 62.0, 63.0, 66.0, 64.0, 60.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1505.2, "alertThreshold": 2.0}]} 10:25:35 INFO - Return code: 0 10:25:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:25:35 ERROR - # TBPL SUCCESS # 10:25:35 INFO - Running post-action listener: _resource_record_post_action 10:25:35 INFO - ##### 10:25:35 INFO - ##### Finished run-tests step (success) 10:25:35 INFO - ##### 10:25:35 INFO - Running post-run listener: _resource_record_post_run 10:25:35 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543244288; Read time: 8; Write time: 569496 10:25:35 INFO - TinderboxPrint: CPU usage
13.1% 10:25:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:25:35 INFO - TinderboxPrint: I/O write bytes / time
543,244,288 / 569,496 10:25:35 INFO - TinderboxPrint: CPU idle
8,255.9 (86.8%) 10:25:35 INFO - TinderboxPrint: CPU user
1,206.1 (12.7%) 10:25:35 INFO - TinderboxPrint: Swap in / out
0 / 0 10:25:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254251008; Read time: 0; Write time: 300068 10:25:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288772096; Read time: 8; Write time: 269404 10:25:35 INFO - Running post-run listener: _upload_blobber_files 10:25:35 INFO - Blob upload gear active. 10:25:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:35 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 10:25:35 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:25:35 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:25:36 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:36 INFO - (blobuploader) - INFO - Done attempting. 10:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:25:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:37 INFO - (blobuploader) - INFO - Done attempting. 10:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:25:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:25:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:42 INFO - (blobuploader) - INFO - Done attempting. 10:25:42 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:42 INFO - Return code: 0 10:25:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b99f4bcd2d31e1c0746164ffeb7c2b44872a761a59900918d97c9ffd7bb27964e8aad83c3acd6728323d3c13276329ad594387510a6be18aa47d9f8263729f30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f705efc6dcc90d95257dbaa8ed8647219f420aba13ed0ffdcd697988176d6168192add645b869521eee3626a69c6b997a2e0c1bfb69457ccb7b973bd253b867", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f6d0b0fb09c50e4b1f9f4b1fa4795e691d0c27a37631bb337d28ffb19cb1680b13962df5ed87edba1c74f5e07d30c1cab048cbcae71dbbbbc4602774b5fc042"} 10:25:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:42 INFO - Contents: 10:25:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b99f4bcd2d31e1c0746164ffeb7c2b44872a761a59900918d97c9ffd7bb27964e8aad83c3acd6728323d3c13276329ad594387510a6be18aa47d9f8263729f30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f705efc6dcc90d95257dbaa8ed8647219f420aba13ed0ffdcd697988176d6168192add645b869521eee3626a69c6b997a2e0c1bfb69457ccb7b973bd253b867", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f6d0b0fb09c50e4b1f9f4b1fa4795e691d0c27a37631bb337d28ffb19cb1680b13962df5ed87edba1c74f5e07d30c1cab048cbcae71dbbbbc4602774b5fc042"} 10:25:42 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:42 INFO - Copying logs to upload dir... 10:25:42 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.612249 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-02 10:25:42.467063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 10:25:42.470821) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302 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/sha512/b99f4bcd2d31e1c0746164ffeb7c2b44872a761a59900918d97c9ffd7bb27964e8aad83c3acd6728323d3c13276329ad594387510a6be18aa47d9f8263729f30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f705efc6dcc90d95257dbaa8ed8647219f420aba13ed0ffdcd697988176d6168192add645b869521eee3626a69c6b997a2e0c1bfb69457ccb7b973bd253b867", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f6d0b0fb09c50e4b1f9f4b1fa4795e691d0c27a37631bb337d28ffb19cb1680b13962df5ed87edba1c74f5e07d30c1cab048cbcae71dbbbbc4602774b5fc042"} build_url:https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011593 build_url: 'https://queue.taskcluster.net/v1/task/da14tfwPRQS90I88QaA3AA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b99f4bcd2d31e1c0746164ffeb7c2b44872a761a59900918d97c9ffd7bb27964e8aad83c3acd6728323d3c13276329ad594387510a6be18aa47d9f8263729f30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f705efc6dcc90d95257dbaa8ed8647219f420aba13ed0ffdcd697988176d6168192add645b869521eee3626a69c6b997a2e0c1bfb69457ccb7b973bd253b867", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f6d0b0fb09c50e4b1f9f4b1fa4795e691d0c27a37631bb337d28ffb19cb1680b13962df5ed87edba1c74f5e07d30c1cab048cbcae71dbbbbc4602774b5fc042"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 10:25:42.496014) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:25:42.496304) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1464887107.237058-1545377302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004802 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 10:25:42.612182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 10:25:42.612476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 10:25:42.612733) ========= ========= Total master_lag: 0.20 =========