builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1467979319.09 results: success (0) buildid: 20160708021326 builduid: 42396063891c4889bb337833f7f3e65f revision: 75b9cc8259df0aca3d93c4b44155a77875341a14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.093116) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.093613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.093948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.109138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.109418) ========= 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-1467979318.444564-1463531910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 05:01:59-- 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% 25.5M=0s 2016-07-08 05:01:59 (25.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.209970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.210292) ========= 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-1467979318.444564-1463531910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016674 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.260195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.260544) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 75b9cc8259df0aca3d93c4b44155a77875341a14 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 75b9cc8259df0aca3d93c4b44155a77875341a14 --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-1467979318.444564-1463531910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 05:01:59,426 truncating revision to first 12 chars 2016-07-08 05:01:59,426 Setting DEBUG logging. 2016-07-08 05:01:59,426 attempt 1/10 2016-07-08 05:01:59,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/75b9cc8259df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 05:01:59,743 unpacking tar archive at: mozilla-beta-75b9cc8259df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.988374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.988699) ========= script_repo_revision: 75b9cc8259df0aca3d93c4b44155a77875341a14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.989142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.989409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:01:59.998484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-08 05:01:59.998753) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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-1467979318.444564-1463531910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:02:00 INFO - MultiFileLogger online at 20160708 05:02:00 in /builds/slave/test 05:02:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:02:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:02:00 INFO - {'append_to_log': False, 05:02:00 INFO - 'base_work_dir': '/builds/slave/test', 05:02:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:02:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:02:00 INFO - 'branch': 'Mozilla-Beta', 05:02:00 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:00 INFO - 'config_files': ('talos/linux_config.py',), 05:02:00 INFO - 'default_actions': ('clobber', 05:02:00 INFO - 'read-buildbot-config', 05:02:00 INFO - 'download-and-extract', 05:02:00 INFO - 'populate-webroot', 05:02:00 INFO - 'create-virtualenv', 05:02:00 INFO - 'install', 05:02:00 INFO - 'run-tests'), 05:02:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:00 INFO - 'download_minidump_stackwalk': True, 05:02:00 INFO - 'download_symbols': 'ondemand', 05:02:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:00 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:00 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:00 INFO - 'installer_path': 'installer.exe', 05:02:00 INFO - 'log_level': 'info', 05:02:00 INFO - 'log_name': 'talos', 05:02:00 INFO - 'log_to_console': True, 05:02:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:02:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:02:00 INFO - 'opt_config_files': (), 05:02:00 INFO - 'pip_index': False, 05:02:00 INFO - 'sps_profile': False, 05:02:00 INFO - 'sps_profile_interval': 0, 05:02:00 INFO - 'suite': 'dromaeojs', 05:02:00 INFO - 'system_bits': '32', 05:02:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:00 INFO - 'title': 'talos-linux64-ix-018', 05:02:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:00 INFO - 'use_talos_json': True, 05:02:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:02:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:00 INFO - 'work_dir': 'build'} 05:02:00 INFO - ##### 05:02:00 INFO - ##### Running clobber step. 05:02:00 INFO - ##### 05:02:00 INFO - Running pre-action listener: _resource_record_pre_action 05:02:00 INFO - Running main action method: clobber 05:02:00 INFO - rmtree: /builds/slave/test/build 05:02:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:02:01 INFO - Running post-action listener: _resource_record_post_action 05:02:01 INFO - ##### 05:02:01 INFO - ##### Running read-buildbot-config step. 05:02:01 INFO - ##### 05:02:01 INFO - Running pre-action listener: _resource_record_pre_action 05:02:01 INFO - Running main action method: read_buildbot_config 05:02:01 INFO - Using buildbot properties: 05:02:01 INFO - { 05:02:01 INFO - "project": "", 05:02:01 INFO - "product": "firefox", 05:02:01 INFO - "script_repo_revision": "production", 05:02:01 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:02:01 INFO - "repository": "", 05:02:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:02:01 INFO - "buildid": "20160708021326", 05:02:01 INFO - "pgo_build": "True", 05:02:01 INFO - "basedir": "/builds/slave/test", 05:02:01 INFO - "buildnumber": 299, 05:02:01 INFO - "slavename": "talos-linux64-ix-018", 05:02:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:02:01 INFO - "platform": "ubuntu64_hw", 05:02:01 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:02:01 INFO - "branch": "mozilla-beta", 05:02:01 INFO - "repo_path": "releases/mozilla-beta", 05:02:01 INFO - "revision": "75b9cc8259df0aca3d93c4b44155a77875341a14", 05:02:01 INFO - "stage_platform": "linux64-pgo", 05:02:01 INFO - "builduid": "42396063891c4889bb337833f7f3e65f", 05:02:01 INFO - "slavebuilddir": "test" 05:02:01 INFO - } 05:02:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:02:01 INFO - Running post-action listener: _resource_record_post_action 05:02:01 INFO - ##### 05:02:01 INFO - ##### Running download-and-extract step. 05:02:01 INFO - ##### 05:02:01 INFO - Running pre-action listener: _resource_record_pre_action 05:02:01 INFO - Running main action method: download_and_extract 05:02:01 INFO - mkdir: /builds/slave/test/build/tests 05:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:01 INFO - https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:02:01 INFO - Downloaded 1327 bytes. 05:02:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:02:01 INFO - Using the following test package requirements: 05:02:01 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:02:01 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:02:01 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:02:01 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:02:01 INFO - u'jsshell-linux-x86_64.zip'], 05:02:01 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:02:01 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:02:01 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:02:01 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:02:01 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:02:01 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:02:01 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:02:01 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:01 INFO - https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:02:02 INFO - Downloaded 24237418 bytes. 05:02:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:02:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:02:04 INFO - Return code: 0 05:02:04 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:04 INFO - https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:02:05 INFO - Downloaded 24237418 bytes. 05:02:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:02:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:02:07 INFO - Return code: 0 05:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:07 INFO - https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:02:07 INFO - Downloaded 10840145 bytes. 05:02:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:02:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:02:08 INFO - Return code: 0 05:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:08 INFO - https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:02:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:02:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:02:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:02:09 INFO - Downloaded 56019799 bytes. 05:02:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:02:09 INFO - mkdir: /builds/slave/test/properties 05:02:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:02:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:02:09 INFO - Contents: 05:02:09 INFO - build_url:https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:02:10 INFO - Running post-action listener: _resource_record_post_action 05:02:10 INFO - Running post-action listener: set_extra_try_arguments 05:02:10 INFO - ##### 05:02:10 INFO - ##### Running populate-webroot step. 05:02:10 INFO - ##### 05:02:10 INFO - Running pre-action listener: _resource_record_pre_action 05:02:10 INFO - Running main action method: populate_webroot 05:02:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:10 INFO - '--tppagecycles', 05:02:10 INFO - '7'], 05:02:10 INFO - 'tests': ['tsvgm']}}, 05:02:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:02:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:02:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:02:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:10 INFO - 'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:10 INFO - 'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['damp', 'tps']}, 05:02:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:10 INFO - 'tests': ['damp', 'tps']}, 05:02:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['dromaeo_dom']}, 05:02:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['a11yr', 05:02:10 INFO - 'ts_paint', 05:02:10 INFO - 'tpaint', 05:02:10 INFO - 'sessionrestore', 05:02:10 INFO - 'sessionrestore_no_auto_restore', 05:02:10 INFO - 'tabpaint']}, 05:02:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:02:10 INFO - 'ts_paint', 05:02:10 INFO - 'tpaint', 05:02:10 INFO - 'sessionrestore', 05:02:10 INFO - 'sessionrestore_no_auto_restore', 05:02:10 INFO - 'tabpaint']}, 05:02:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:02:10 INFO - 'ts_paint', 05:02:10 INFO - 'tpaint', 05:02:10 INFO - 'sessionrestore', 05:02:10 INFO - 'sessionrestore_no_auto_restore', 05:02:10 INFO - 'tabpaint']}, 05:02:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:02:10 INFO - 'ts_paint', 05:02:10 INFO - 'tpaint', 05:02:10 INFO - 'sessionrestore', 05:02:10 INFO - 'sessionrestore_no_auto_restore', 05:02:10 INFO - 'tabpaint']}, 05:02:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['a11yr', 05:02:10 INFO - 'ts_paint', 05:02:10 INFO - 'tpaint', 05:02:10 INFO - 'sessionrestore', 05:02:10 INFO - 'sessionrestore_no_auto_restore', 05:02:10 INFO - 'tabpaint']}, 05:02:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['a11yr', 05:02:10 INFO - 'ts_paint', 05:02:10 INFO - 'tpaint', 05:02:10 INFO - 'sessionrestore', 05:02:10 INFO - 'sessionrestore_no_auto_restore', 05:02:10 INFO - 'tabpaint']}, 05:02:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['tsvgx', 05:02:10 INFO - 'tsvgr_opacity', 05:02:10 INFO - 'tart', 05:02:10 INFO - 'tscrollx', 05:02:10 INFO - 'cart']}, 05:02:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:02:10 INFO - 'tsvgr_opacity', 05:02:10 INFO - 'tart', 05:02:10 INFO - 'tscrollx', 05:02:10 INFO - 'cart']}, 05:02:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:10 INFO - 'talos_options': ['--disable-e10s'], 05:02:10 INFO - 'tests': ['tp5o']}, 05:02:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:10 INFO - 'tests': ['tp5o']}, 05:02:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:10 INFO - 'talos_options': ['--disable-e10s', 05:02:10 INFO - '--xperf_path', 05:02:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:10 INFO - 'tests': ['tp5n']}, 05:02:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:10 INFO - 'talos_options': ['--xperf_path', 05:02:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:10 INFO - 'tests': ['tp5n']}}, 05:02:10 INFO - 'talos.zip': {'path': '', 05:02:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:10 INFO - Running post-action listener: _resource_record_post_action 05:02:10 INFO - ##### 05:02:10 INFO - ##### Running create-virtualenv step. 05:02:10 INFO - ##### 05:02:10 INFO - Running pre-action listener: _resource_record_pre_action 05:02:10 INFO - Running main action method: create_virtualenv 05:02:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:02:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:02:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:02:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:10 INFO - Using real prefix '/usr' 05:02:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:02:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:12 INFO - Installing pip.................done. 05:02:12 INFO - Return code: 0 05:02:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 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 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:02:13 INFO - Using env: {'DISPLAY': ':0', 05:02:13 INFO - 'HOME': '/home/cltbld', 05:02:13 INFO - 'LANG': 'en_US.UTF-8', 05:02:13 INFO - 'LANGUAGE': 'en_US:en', 05:02:13 INFO - 'LOGNAME': 'cltbld', 05:02:13 INFO - 'MAIL': '/var/mail/cltbld', 05:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:13 INFO - 'MOZ_NO_REMOTE': '1', 05:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:13 INFO - 'NO_EM_RESTART': '1', 05:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:13 INFO - 'PWD': '/builds/slave/test', 05:02:13 INFO - 'SHELL': '/bin/bash', 05:02:13 INFO - 'SHLVL': '1', 05:02:13 INFO - 'TERM': 'linux', 05:02:13 INFO - 'TMOUT': '86400', 05:02:13 INFO - 'USER': 'cltbld', 05:02:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:13 INFO - '_': '/tools/buildbot/bin/python'} 05:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:02:13 INFO - Cleaning up... 05:02:13 INFO - Return code: 0 05:02:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:02:13 INFO - Using env: {'DISPLAY': ':0', 05:02:13 INFO - 'HOME': '/home/cltbld', 05:02:13 INFO - 'LANG': 'en_US.UTF-8', 05:02:13 INFO - 'LANGUAGE': 'en_US:en', 05:02:13 INFO - 'LOGNAME': 'cltbld', 05:02:13 INFO - 'MAIL': '/var/mail/cltbld', 05:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:13 INFO - 'MOZ_NO_REMOTE': '1', 05:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:13 INFO - 'NO_EM_RESTART': '1', 05:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:13 INFO - 'PWD': '/builds/slave/test', 05:02:13 INFO - 'SHELL': '/bin/bash', 05:02:13 INFO - 'SHLVL': '1', 05:02:13 INFO - 'TERM': 'linux', 05:02:13 INFO - 'TMOUT': '86400', 05:02:13 INFO - 'USER': 'cltbld', 05:02:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:13 INFO - '_': '/tools/buildbot/bin/python'} 05:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:13 INFO - Downloading/unpacking psutil>=0.7.1 05:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:15 INFO - Installing collected packages: psutil 05:02:15 INFO - Running setup.py install for psutil 05:02:15 INFO - building 'psutil._psutil_linux' extension 05:02:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:02:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:02:15 INFO - building 'psutil._psutil_posix' extension 05:02:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:02:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:02:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:15 INFO - Successfully installed psutil 05:02:15 INFO - Cleaning up... 05:02:16 INFO - Return code: 0 05:02:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:02:16 INFO - Using env: {'DISPLAY': ':0', 05:02:16 INFO - 'HOME': '/home/cltbld', 05:02:16 INFO - 'LANG': 'en_US.UTF-8', 05:02:16 INFO - 'LANGUAGE': 'en_US:en', 05:02:16 INFO - 'LOGNAME': 'cltbld', 05:02:16 INFO - 'MAIL': '/var/mail/cltbld', 05:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:16 INFO - 'MOZ_NO_REMOTE': '1', 05:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:16 INFO - 'NO_EM_RESTART': '1', 05:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:16 INFO - 'PWD': '/builds/slave/test', 05:02:16 INFO - 'SHELL': '/bin/bash', 05:02:16 INFO - 'SHLVL': '1', 05:02:16 INFO - 'TERM': 'linux', 05:02:16 INFO - 'TMOUT': '86400', 05:02:16 INFO - 'USER': 'cltbld', 05:02:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:16 INFO - '_': '/tools/buildbot/bin/python'} 05:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:02:18 INFO - Installing collected packages: mozsystemmonitor 05:02:18 INFO - Running setup.py install for mozsystemmonitor 05:02:18 INFO - Successfully installed mozsystemmonitor 05:02:18 INFO - Cleaning up... 05:02:18 INFO - Return code: 0 05:02:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:18 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 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:02:18 INFO - Using env: {'DISPLAY': ':0', 05:02:18 INFO - 'HOME': '/home/cltbld', 05:02:18 INFO - 'LANG': 'en_US.UTF-8', 05:02:18 INFO - 'LANGUAGE': 'en_US:en', 05:02:18 INFO - 'LOGNAME': 'cltbld', 05:02:18 INFO - 'MAIL': '/var/mail/cltbld', 05:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:18 INFO - 'MOZ_NO_REMOTE': '1', 05:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:18 INFO - 'NO_EM_RESTART': '1', 05:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:18 INFO - 'PWD': '/builds/slave/test', 05:02:18 INFO - 'SHELL': '/bin/bash', 05:02:18 INFO - 'SHLVL': '1', 05:02:18 INFO - 'TERM': 'linux', 05:02:18 INFO - 'TMOUT': '86400', 05:02:18 INFO - 'USER': 'cltbld', 05:02:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:18 INFO - '_': '/tools/buildbot/bin/python'} 05:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:21 INFO - Downloading docopt-0.6.1.tar.gz 05:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:21 INFO - Running setup.py install for blobuploader 05:02:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:21 INFO - Running setup.py install for requests 05:02:21 INFO - Running setup.py install for docopt 05:02:21 INFO - Successfully installed blobuploader requests docopt 05:02:21 INFO - Cleaning up... 05:02:21 INFO - Return code: 0 05:02:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:21 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 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:21 INFO - Using env: {'DISPLAY': ':0', 05:02:21 INFO - 'HOME': '/home/cltbld', 05:02:21 INFO - 'LANG': 'en_US.UTF-8', 05:02:21 INFO - 'LANGUAGE': 'en_US:en', 05:02:21 INFO - 'LOGNAME': 'cltbld', 05:02:21 INFO - 'MAIL': '/var/mail/cltbld', 05:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:21 INFO - 'MOZ_NO_REMOTE': '1', 05:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:21 INFO - 'NO_EM_RESTART': '1', 05:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:21 INFO - 'PWD': '/builds/slave/test', 05:02:21 INFO - 'SHELL': '/bin/bash', 05:02:21 INFO - 'SHLVL': '1', 05:02:21 INFO - 'TERM': 'linux', 05:02:21 INFO - 'TMOUT': '86400', 05:02:21 INFO - 'USER': 'cltbld', 05:02:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:21 INFO - '_': '/tools/buildbot/bin/python'} 05:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:22 INFO - Running setup.py (path:/tmp/pip-Ug6MqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:22 INFO - Running setup.py (path:/tmp/pip-UVXcKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:22 INFO - Running setup.py (path:/tmp/pip-F6j1WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:22 INFO - Running setup.py (path:/tmp/pip-h6idNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:22 INFO - Running setup.py (path:/tmp/pip-N8NtoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:22 INFO - Running setup.py (path:/tmp/pip-1T3XeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:22 INFO - Running setup.py (path:/tmp/pip-qD5idc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:22 INFO - Running setup.py (path:/tmp/pip-BYflMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:22 INFO - Running setup.py (path:/tmp/pip-ku4SOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:22 INFO - Running setup.py (path:/tmp/pip-QTdnB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:22 INFO - Running setup.py (path:/tmp/pip-4NMQAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:22 INFO - Running setup.py (path:/tmp/pip-AYU0fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:22 INFO - Running setup.py (path:/tmp/pip-l7K_o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:23 INFO - Running setup.py (path:/tmp/pip-PgvPHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:23 INFO - Running setup.py (path:/tmp/pip-30v1h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:23 INFO - Running setup.py (path:/tmp/pip-2BDXxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:23 INFO - Running setup.py (path:/tmp/pip-CwodTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:23 INFO - Running setup.py install for manifestparser 05:02:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:23 INFO - Running setup.py install for mozcrash 05:02:23 INFO - Running setup.py install for mozdebug 05:02:23 INFO - Running setup.py install for mozdevice 05:02:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:02:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:23 INFO - Running setup.py install for mozfile 05:02:23 INFO - Running setup.py install for mozhttpd 05:02:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:23 INFO - Running setup.py install for mozinfo 05:02:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Running setup.py install for mozInstall 05:02:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Running setup.py install for mozleak 05:02:24 INFO - Running setup.py install for mozlog 05:02:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Running setup.py install for moznetwork 05:02:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Running setup.py install for mozprocess 05:02:24 INFO - Running setup.py install for mozprofile 05:02:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Running setup.py install for mozrunner 05:02:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:24 INFO - Running setup.py install for mozscreenshot 05:02:24 INFO - Running setup.py install for moztest 05:02:25 INFO - Running setup.py install for mozversion 05:02:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:25 INFO - Cleaning up... 05:02:25 INFO - Return code: 0 05:02:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:25 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 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:25 INFO - Using env: {'DISPLAY': ':0', 05:02:25 INFO - 'HOME': '/home/cltbld', 05:02:25 INFO - 'LANG': 'en_US.UTF-8', 05:02:25 INFO - 'LANGUAGE': 'en_US:en', 05:02:25 INFO - 'LOGNAME': 'cltbld', 05:02:25 INFO - 'MAIL': '/var/mail/cltbld', 05:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:25 INFO - 'MOZ_NO_REMOTE': '1', 05:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:25 INFO - 'NO_EM_RESTART': '1', 05:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:25 INFO - 'PWD': '/builds/slave/test', 05:02:25 INFO - 'SHELL': '/bin/bash', 05:02:25 INFO - 'SHLVL': '1', 05:02:25 INFO - 'TERM': 'linux', 05:02:25 INFO - 'TMOUT': '86400', 05:02:25 INFO - 'USER': 'cltbld', 05:02:25 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:25 INFO - '_': '/tools/buildbot/bin/python'} 05:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:25 INFO - Running setup.py (path:/tmp/pip-L2H98A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:25 INFO - Running setup.py (path:/tmp/pip-eabC9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:25 INFO - Running setup.py (path:/tmp/pip-qyy2mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:25 INFO - Running setup.py (path:/tmp/pip-gBmJ90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:25 INFO - Running setup.py (path:/tmp/pip-2Y7Pf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:25 INFO - Running setup.py (path:/tmp/pip-Ehw301-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:25 INFO - Running setup.py (path:/tmp/pip-_W95qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:25 INFO - Running setup.py (path:/tmp/pip-isMYNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:25 INFO - Running setup.py (path:/tmp/pip-Pu_20h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:26 INFO - Running setup.py (path:/tmp/pip-gYDtsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:26 INFO - Running setup.py (path:/tmp/pip-etdeGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:26 INFO - Running setup.py (path:/tmp/pip-mPj0QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:26 INFO - Running setup.py (path:/tmp/pip-eILkrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:26 INFO - Running setup.py (path:/tmp/pip-Mvarxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:26 INFO - Running setup.py (path:/tmp/pip-RCgzSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:26 INFO - Running setup.py (path:/tmp/pip-nuYxGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:26 INFO - Running setup.py (path:/tmp/pip-5EgYUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:28 INFO - Downloading blessings-1.6.tar.gz 05:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:28 INFO - Installing collected packages: blessings 05:02:28 INFO - Running setup.py install for blessings 05:02:28 INFO - Successfully installed blessings 05:02:28 INFO - Cleaning up... 05:02:28 INFO - Return code: 0 05:02:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:28 INFO - Reading from file tmpfile_stdout 05:02:28 INFO - Current package versions: 05:02:28 INFO - argparse == 1.2.1 05:02:28 INFO - blessings == 1.6 05:02:28 INFO - blobuploader == 1.2.4 05:02:28 INFO - docopt == 0.6.1 05:02:28 INFO - manifestparser == 1.1 05:02:28 INFO - mozInstall == 1.12 05:02:28 INFO - mozcrash == 0.17 05:02:28 INFO - mozdebug == 0.1 05:02:28 INFO - mozdevice == 0.48 05:02:28 INFO - mozfile == 1.2 05:02:28 INFO - mozhttpd == 0.7 05:02:28 INFO - mozinfo == 0.9 05:02:28 INFO - mozleak == 0.1 05:02:28 INFO - mozlog == 3.1 05:02:28 INFO - moznetwork == 0.27 05:02:28 INFO - mozprocess == 0.22 05:02:28 INFO - mozprofile == 0.28 05:02:28 INFO - mozrunner == 6.11 05:02:28 INFO - mozscreenshot == 0.1 05:02:28 INFO - mozsystemmonitor == 0.0 05:02:28 INFO - moztest == 0.7 05:02:28 INFO - mozversion == 1.4 05:02:28 INFO - psutil == 3.1.1 05:02:28 INFO - requests == 1.2.3 05:02:28 INFO - wsgiref == 0.1.2 05:02:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:28 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 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:28 INFO - Using env: {'DISPLAY': ':0', 05:02:28 INFO - 'HOME': '/home/cltbld', 05:02:28 INFO - 'LANG': 'en_US.UTF-8', 05:02:28 INFO - 'LANGUAGE': 'en_US:en', 05:02:28 INFO - 'LOGNAME': 'cltbld', 05:02:28 INFO - 'MAIL': '/var/mail/cltbld', 05:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:28 INFO - 'MOZ_NO_REMOTE': '1', 05:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:28 INFO - 'NO_EM_RESTART': '1', 05:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:28 INFO - 'PWD': '/builds/slave/test', 05:02:28 INFO - 'SHELL': '/bin/bash', 05:02:28 INFO - 'SHLVL': '1', 05:02:28 INFO - 'TERM': 'linux', 05:02:28 INFO - 'TMOUT': '86400', 05:02:28 INFO - 'USER': 'cltbld', 05:02:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:28 INFO - '_': '/tools/buildbot/bin/python'} 05:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:02:29 INFO - Cleaning up... 05:02:29 INFO - Return code: 0 05:02:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:29 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 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:02:29 INFO - Using env: {'DISPLAY': ':0', 05:02:29 INFO - 'HOME': '/home/cltbld', 05:02:29 INFO - 'LANG': 'en_US.UTF-8', 05:02:29 INFO - 'LANGUAGE': 'en_US:en', 05:02:29 INFO - 'LOGNAME': 'cltbld', 05:02:29 INFO - 'MAIL': '/var/mail/cltbld', 05:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:29 INFO - 'MOZ_NO_REMOTE': '1', 05:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:29 INFO - 'NO_EM_RESTART': '1', 05:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:29 INFO - 'PWD': '/builds/slave/test', 05:02:29 INFO - 'SHELL': '/bin/bash', 05:02:29 INFO - 'SHLVL': '1', 05:02:29 INFO - 'TERM': 'linux', 05:02:29 INFO - 'TMOUT': '86400', 05:02:29 INFO - 'USER': 'cltbld', 05:02:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:29 INFO - '_': '/tools/buildbot/bin/python'} 05:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:29 INFO - Downloading/unpacking jsonschema 05:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:31 INFO - Downloading/unpacking functools32 (from jsonschema) 05:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:31 INFO - warning: no files found matching '*.txt' 05:02:31 INFO - no previously-included directories found matching 'build' 05:02:31 INFO - no previously-included directories found matching 'dist' 05:02:31 INFO - no previously-included directories found matching '.git*' 05:02:31 INFO - Installing collected packages: jsonschema, functools32 05:02:31 INFO - Running setup.py install for functools32 05:02:31 INFO - warning: no files found matching '*.txt' 05:02:31 INFO - no previously-included directories found matching 'build' 05:02:31 INFO - no previously-included directories found matching 'dist' 05:02:31 INFO - no previously-included directories found matching '.git*' 05:02:31 INFO - Successfully installed jsonschema functools32 05:02:31 INFO - Cleaning up... 05:02:31 INFO - Return code: 0 05:02:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:31 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 0x7fde9e329f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, '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-1467979318.444564-1463531910', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:02:31 INFO - Using env: {'DISPLAY': ':0', 05:02:31 INFO - 'HOME': '/home/cltbld', 05:02:31 INFO - 'LANG': 'en_US.UTF-8', 05:02:31 INFO - 'LANGUAGE': 'en_US:en', 05:02:31 INFO - 'LOGNAME': 'cltbld', 05:02:31 INFO - 'MAIL': '/var/mail/cltbld', 05:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:31 INFO - 'MOZ_NO_REMOTE': '1', 05:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:31 INFO - 'NO_EM_RESTART': '1', 05:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:31 INFO - 'PWD': '/builds/slave/test', 05:02:31 INFO - 'SHELL': '/bin/bash', 05:02:31 INFO - 'SHLVL': '1', 05:02:31 INFO - 'TERM': 'linux', 05:02:31 INFO - 'TMOUT': '86400', 05:02:31 INFO - 'USER': 'cltbld', 05:02:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:31 INFO - '_': '/tools/buildbot/bin/python'} 05:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:31 INFO - Downloading/unpacking flake8 05:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:02:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:02:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:02:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:34 INFO - no previously-included directories found matching 'docs/_build' 05:02:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:02:34 INFO - Running setup.py install for pep8 05:02:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:34 INFO - no previously-included directories found matching 'docs/_build' 05:02:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:02:34 INFO - Cleaning up... 05:02:34 INFO - Return code: 0 05:02:34 INFO - Running post-action listener: _resource_record_post_action 05:02:34 INFO - Running post-action listener: _start_resource_monitoring 05:02:34 INFO - Starting resource monitoring. 05:02:34 INFO - ##### 05:02:34 INFO - ##### Running install step. 05:02:34 INFO - ##### 05:02:34 INFO - Running pre-action listener: _resource_record_pre_action 05:02:34 INFO - Running main action method: install 05:02:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:35 INFO - Reading from file tmpfile_stdout 05:02:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:35 INFO - Reading from file tmpfile_stdout 05:02:35 INFO - Output received: 05:02:35 INFO - Usage: mozinstall [options] installer 05:02:35 INFO - Options: 05:02:35 INFO - -h, --help show this help message and exit 05:02:35 INFO - -d DEST, --destination=DEST 05:02:35 INFO - Directory to install application into. [default: 05:02:35 INFO - "/builds/slave/test"] 05:02:35 INFO - --app=APP Application being installed. [default: firefox] 05:02:35 INFO - mkdir: /builds/slave/test/build/application 05:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:02:48 INFO - Reading from file tmpfile_stdout 05:02:48 INFO - Output received: 05:02:48 INFO - /builds/slave/test/build/application/firefox/firefox 05:02:48 INFO - Running post-action listener: _resource_record_post_action 05:02:48 INFO - ##### 05:02:48 INFO - ##### Running run-tests step. 05:02:48 INFO - ##### 05:02:48 INFO - Running pre-action listener: _resource_record_pre_action 05:02:48 INFO - Running main action method: run_tests 05:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:48 INFO - Python 2.7.3 05:02:48 INFO - Return code: 0 05:02:48 INFO - grabbing minidump binary from tooltool 05:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ae410>, '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 0x24af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24af7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:02:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:02:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:48 INFO - Return code: 0 05:02:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:02:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:02:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:02:49 INFO - Return code: 0 05:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:02:49 INFO - Using env: {'DISPLAY': ':0', 05:02:49 INFO - 'HOME': '/home/cltbld', 05:02:49 INFO - 'LANG': 'en_US.UTF-8', 05:02:49 INFO - 'LANGUAGE': 'en_US:en', 05:02:49 INFO - 'LOGNAME': 'cltbld', 05:02:49 INFO - 'MAIL': '/var/mail/cltbld', 05:02:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:49 INFO - 'MOZ_NO_REMOTE': '1', 05:02:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:49 INFO - 'NO_EM_RESTART': '1', 05:02:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:49 INFO - 'PWD': '/builds/slave/test', 05:02:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:49 INFO - 'SHELL': '/bin/bash', 05:02:49 INFO - 'SHLVL': '1', 05:02:49 INFO - 'TERM': 'linux', 05:02:49 INFO - 'TMOUT': '86400', 05:02:49 INFO - 'USER': 'cltbld', 05:02:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467979318.444564-1463531910', 05:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:49 INFO - '_': '/tools/buildbot/bin/python'} 05:02:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:02:49 INFO - mozversion application_buildid: 20160708021326 05:02:49 INFO - mozversion application_changeset: 75b9cc8259df0aca3d93c4b44155a77875341a14 05:02:49 INFO - mozversion application_display_name: Firefox 05:02:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:49 INFO - mozversion application_name: Firefox 05:02:49 INFO - mozversion application_remotingname: firefox 05:02:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:02:49 INFO - mozversion application_vendor: Mozilla 05:02:49 INFO - mozversion application_version: 48.0 05:02:49 INFO - mozversion platform_buildid: 20160708021326 05:02:49 INFO - mozversion platform_changeset: 75b9cc8259df0aca3d93c4b44155a77875341a14 05:02:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:02:49 INFO - mozversion platform_version: 48.0 05:02:49 INFO - using testdate: 1467979369 05:02:49 INFO - actual date: 1467979369 05:02:49 INFO - starting webserver on 'localhost:49171' 05:02:49 INFO - SUITE-START | Running 2 tests 05:02:49 INFO - TEST-START | dromaeo_css 05:02:49 INFO - operating with platform_type : linux_ 05:02:49 INFO - Initialising browser for dromaeo_css test... 05:02:49 INFO - TEST-INFO | started process 20890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJR6lxW/profile http://localhost:49171/getInfo.html) 05:02:53 INFO - PROCESS | 20890 | __metrics Screen width/height:1600/1200 05:02:53 INFO - PROCESS | 20890 | colorDepth:24 05:02:53 INFO - PROCESS | 20890 | Browser inner width/height: 1024/697 05:02:53 INFO - PROCESS | 20890 | __metrics 05:02:54 ERROR - PROCESS | 20890 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:02:54 INFO - TEST-INFO | 20890: exit 0 05:02:54 INFO - Browser initialized. 05:02:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:54 INFO - TEST-INFO | started process 20981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJR6lxW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:06 INFO - PROCESS | 20981 | RSS: Main: 139702272 05:03:06 INFO - PROCESS | 20981 | 05:03:57 INFO - PROCESS | 20981 | 1467979437514 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:06:05 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:49171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49171/tests/dromaeo/cssquery-ext.html) 05:06:05 INFO - PROCESS | 20981 | RSS: Main: 244510720 05:06:05 INFO - PROCESS | 20981 | 05:09:08 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:49171/tests/dromaeo/cssquery-ext.html (next: http://localhost:49171/tests/dromaeo/cssquery-jquery.html) 05:09:08 INFO - PROCESS | 20981 | RSS: Main: 225624064 05:09:08 INFO - PROCESS | 20981 | 05:12:10 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:49171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49171/tests/dromaeo/cssquery-mootools.html) 05:12:11 INFO - PROCESS | 20981 | RSS: Main: 222097408 05:12:11 INFO - PROCESS | 20981 | 05:15:12 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:49171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49171/tests/dromaeo/cssquery-prototype.html) 05:15:13 INFO - PROCESS | 20981 | RSS: Main: 217600000 05:15:13 INFO - PROCESS | 20981 | 05:18:15 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:49171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49171/tests/dromaeo/cssquery-yui.html) 05:18:16 INFO - PROCESS | 20981 | RSS: Main: 210677760 05:18:16 INFO - PROCESS | 20981 | 05:21:18 INFO - PROCESS | 20981 | Cycle 1(1): loaded http://localhost:49171/tests/dromaeo/cssquery-yui.html (next: http://localhost:49171/tests/dromaeo/cssquery-dojo.html) 05:21:19 INFO - PROCESS | 20981 | RSS: Main: 258457600 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - PROCESS | 20981 | __start_tp_report 05:21:19 INFO - PROCESS | 20981 | _x_x_mozilla_page_load 05:21:19 INFO - PROCESS | 20981 | _x_x_mozilla_page_load_details 05:21:19 INFO - PROCESS | 20981 | |i|pagename|runs| 05:21:19 INFO - PROCESS | 20981 | |0;dojo.html;3268.9509657355143;3343.799372037678;3346.899593012209;3376.35849188654;3380.9492857607124;5471.562275017999;5487.725613719313;5506.366767821702;5514.724263786815;5526.834194974147;5478.369987451444;5529.30883639545;5532.612717109804;5534.308211473556;5571.749271282792;4944.085344211315;4959.876003099925;5036.395632524102;5083.517065878736;5107.029664363759;4882.853514394574;4967.577755890754;4975.402951645808;4998.875028124289;5005.374328208974;4965.925511117336;4970.552650261476;4994.550490455858;5020.799168033274;5062.721550314731;5030.471800460954;5064.493550644943;5078.390593128848;5079.187330027215;5108.310378098946;4928.778204980785;4933.827316043958;4981.227909674007;4985.925211121836;4995.200767877122;5381.623286369956;5400.567954563626;5401.78392864285;5403.297571315704;5405.5135037846785;5676.375598684142;5718.742656580423;5720.856978575569;5723.141528770676;5737.942620573783;5817.389174136697;5889.204957330749;5983.132445795379;6026.2165918430765;6044.1840351552855;5421.186821976696;5455.645383050089;5473.28847249855;5483.698396588186;5522.22688823565;5858;5972.701364931736;5974.2233509643465;5974.402559744078;5977.402259773988;5761.251037365116;5821.7380217890295;5836.591438599342;5837;5838.649681019152;5906.40935906406;5907.4683278505145;5918.2898052234;5920.615160014585;5921.703914804329;5713.200151978726;5792.4497172768515;5879.823605291848;5883.970580147072;5885.323187833454;5879.088741245114;5892.646441213541;5896.174535565025;5896.439838215363;5927.881442371215;4508.323751437245;4518.841840535565;4519.480259770103;4521.3896124023495;4544.636429085665;3972.920541589152;3987.3620220764537;4021.2761702893176;4024.7987600619854;4066.2274167908004;5515.117581186991;5578.330600327987;5604.355499117572;5613.522850557748;5618.971905140448;5882.117682347596;5893.381194974551;5894.823155305347;5895.764169433261;5904.439078287556;5482.479164479368;5517.806876759294;5564.443555644484;5628.183913332544;5639.295088113986;5006.549410553068;5014.52362025607;5034.169362055293;5036.5718913892;5037.647364684437;6163.075538669146;6179.16581261533;6181.103739957681;6185.721642526007;6193.256809182837;5724.370319264961;5899.882002359929;5908.645481271137;5987.101934709654;6022.277326720821;6176.907346389898;6186.659733714689;6213.2233470816145;6216.974199257072;6230.43926046658;5830.096335068071;5834.445727655866;5836.678982655994;5843.970780146072;5845.3570107289015;5725.427457254241;5919.052951527735;5921.2006379138265;6005.459508644243;6021.157038014769;5739.770409183586;5787.826365209051;5790.7973220937065;5802.535797136304;5810.360860305447;5721.971390143022;5755.1942728017275;5774.0761478163295;5779.422057794187;5785.884282314246;5501.284832971688;5627.662340259598;5639.3232812062815;5674.404187560247;5721.284839395075;5790.1893734877995;5814.680192589448;5834.03738383179;5838.211841401527;5845.064789633639;5510.889782204414;5701.600887937804;5713.857153571194;5716.199732037435;5732.512736417451 05:21:19 INFO - PROCESS | 20981 | |1;ext.html;607.9848003799905;660.867826434713;672.6569449580712;686.6909890549254;695.1970474102413;31872;32547.186320342003;39925.80037099818;40845;40855.387169192414;44722;45469.54530454695;45540;45556.544434555646;45564.77217613916;7692.615369231544;8945.552722363873;9124;9124.58939347731;10515.106215971651;10616.20378471614;10752.301100428485;10753.78492430151;10755.784884302348;10761.246712730112;10768.030877221048;10821.458927053616;10832.891671083307;10838.187135964794;10840.837387439195;10651.25441219115;10721.731956701067;10726.946365268124;10728.678139655824;10729.517171727291;10634.521446534924;10763.031327180592;10776.137908967265;11055.336679799238;11066.723331916686;44289.11421771579;44376.77811610953;44780.3282950756;44835.77582112069;44865.32702009472;3869.303525365433;4276.294411422112;4390.4511936008;4527.094581083797;4622.8382006629945;34037.6596234037;35071.64928350735;35688.46467302993;36565;37014.629853701656;4519.683622146451;4563.977180114111;4729.148753224418;4771.928431002644;4814.470408255089;224102;226206.99999999834;226262;227009;227446;60036.69981650151;60161;60531;60617.393826062056;60664.39335606588;72889;74584.62707686427;74613;74631.25368746243;74632.25367746253;18839.340623078126;18991.810081899002;19023.048847557566;19059.80940190608;19062.714059289123;13509.59471215865;14633.122012679274;14728.116313021254;15085.170315632526;15140.394384224508;20646.587068258552;20819;20842.062107205213;20849.374518764158;20855.37433876986;7509.924900751032;7528.209537998431;7586.696532138652;7740.8451830964195;7830.216978302238;1136.2387200575633;1176.9348739390864;1182.8639706433698;1225.5587988324196;1283.6277479531018;33777.49333759995;34370.48444273338;34418.31163376718;34631.480527792104;34764.30471390558;1214.5809695654984;1260.9180403273758;1268.6384380451527;1275.1265383212528;1324.72843067171;17612.823871761117;17852.821471785377;17921.103944802708;17948.192331345123;18314.542136446697;474560;476582;480588;480772;481577;64147.358526415075;64847.35152648507;65098.674506628115;65237.347626524075;65288.673556632864;1415.469199050356;1458.3000159923297;1541.368039103962;1573.1190533301387;1674.4809109176194;31587.684123158473;33062.33875322432;33249;33826.15434614154;33830.661693383736;51296.48703512917;51716.74141629268;51831.48168518267;51881.7405912968;51904.221436677726;291751;292295;293611;293867;294131;28714.138575842757;28769;28840;30904.69095309108;31339;51585;52053;52578.47421525736;52818.20772688336;54519.45480545144;42587;43302.78348608237;43843.56156438395;44354.33468498039;44815;42717.35923961205;42913;43565.78217108894;43934.78032609817;44228.77885610551;45008.77495612501;45345.319820202065;46058;46687.29969050399;47061.05877882492;33290.66709332875;34839;35283.82358088193;35973.46039809353;36019.279614408086;27303.726962730914;28289.292767680974;28738.568921465776;29118.56322155127;29119.417611647226 05:21:19 INFO - PROCESS | 20981 | |2;jquery.html;429.3452484960436;429.9806508707108;432.3816941773263;436.4435344935207;442.59060369158533;18719.3448229312;18843;19203;19289.22843086275;19469.31857384992;18539;18716.906415467904;19422.90288548559;19512.219511219533;19512.512187195327;5425.538829199503;5672.886542269162;5832.1834943108;5841.853953651172;5847.649141051551;4201.390798334255;5756.338021127561;5808.12878068289;6202.131701561785;6501.7724379646725;6475.158229430168;6485.546011779177;6497;6499.870002599945;6503.577267477623;5561.332640083196;5802.274715660543;5815.883682326372;5818.1272809078555;6426;3858.9421158682644;3975.463312452811;5490.423505531941;5662.320521537442;5671.517920976722;14019.158850468903;14214.928925355307;14225.07537010091;14240.287985600782;20936.47658808527;2434.9878250608635;2514.7610976957158;2518.7103483099313;2533.7972962163167;2829.9434011319863;10056.798864022678;10204.336718113298;10234.385936843813;10260.486975651187;10314.793704125876;1932.1498540642071;1943.504406376365;2020.4847763820278;2092.550101728136;2136.0174319812904;77564.61217693875;80853;80901.59549202275;81221.59389203075;81657.18342816555;11164;11345.319280843176;11355.659330220107;11452;11669.299842009337;15774.842251577338;15806.68386632261;15937.167225768953;15946.20268986546;15950.601234968986;8451.492910425393;8634.56827158652;8983.056779038237;9010.819783604291;9078.682246121354;8920.152585504367;8925.910740892508;8996.325275604357;9039.909600904039;9062.410943288665;4686.671932964728;4717.127331443694;4809.615230781599;4916.483769204182;4929.876753081202;1805.4506761858954;2021.777604463508;2066.338771593106;2079.55157487381;2079.760827504826;1032.339302846179;1118.2675347647305;1122.3602546548389;1123.5449642894641;1144.5707859552667;17024.744628830576;18640.72038919417;18942.905285473484;18990.81009189918;19067.141978610995;1074.55406006508;1084.7776205877776;1090.4057288777635;1091.4870011094772;1102.3826657072066;10264.281500295057;10749.785004300027;10890.401027943539;10892.183086268404;11034.779304414027;473059;489444;504743;528828;538832;88556.11443885608;90824;91204.88103473275;91791;94155;1046.8902962859393;1048.8846226915034;1124.0501775999267;1146.340854008948;1150.511032811052;16830.158492075592;16959;17067;17085.48743537696;17172.656546868744;38350.23299534049;38576.22847542977;40295.597044029186;40403.1919361617;40616.593834061285;54611.45388546223;57054.7147264261;57719.422805771406;57941;57946;9014.278857691237;9159.725208243763;9235.953820230856;9245.399049061789;9253.240279162512;12778.936105319413;13837.930810345884;13987.860121398655;14000.579982600539;14042.719145617235;11698.649040528799;11842.230255033395;12129.514819407124;12308.630741077783;12363.69090772738;11675.649730508097;11715.121365897763;11774.811352320605;11904.226225295328;11910.404479775803;12141.817872732092;12465.688357791129;12491.750164996467;12506.687332816753;12587.24476531411;8931.955340223258;8949.910500894908;9011.459312441275;9086.273098152264;9250.259979201513;11795.823062654239;11969.281843089442;12112.576059837864;12123.211991220542;12538.811917821058 05:21:19 INFO - PROCESS | 20981 | |3;mootools.html;1419;1615.030981411153;1616.12538422833;1854.656888475632;1956.4032969944171;8199.262066414021;8448.028476725187;8449.281811046061;8452.366072544568;8462.153784621534;8305.792355191123;8483.490990540557;8485.278751306147;8490.872636910452;8503.91496085039;2402.903883844644;2428.8178386620984;2429.3805079704653;2433.5862903306393;2436.2082323244927;2356.7171939367213;2412.963805542918;2443.6823212982285;2445.461998360358;2448.7796098351146;2388.844725092872;2402.7477114902945;2410.650455683925;2458.53287875304;2459.348272707734;2331.7668233176714;2364.680768096302;2382.4996750682376;2395.3532546212514;2398.400399900025;2373.0507796881384;2424.224248240546;2438.1588352018525;2438.7927026202615;2440.9511809763885;7319.194888562254;7489.063867016623;8685;8707.608157632858;8726.52004139772;5107.668001579923;5204.063268611649;5206.843794686166;5207.531322180984;5208.244804503363;3556.76881002734;3557.288542291526;3609.097725568608;3646.453032045188;3665.0287673766475;1153.4578747988432;1188.8632807227193;1191.326900301327;1212.7574485102925;1263.1789336930976;12008.279503229835;12096.879031209752;12155.027597792156;12203.69490762738;12209.389530523438;4660.04469083837;4727.57451829337;4730.881727956828;4760.190767569521;4862.635302352267;10401.427921464392;10431.94784026075;10451.947740261403;10452.895471045344;10456.163506919429;5458.235846981426;5504.339479262434;5512.6692398456225;5514.503694667419;5516.613837031369;4934.629902757308;5029.27075574047;5045.9747701261995;5047.116754567936;5047.545720885065;4031.8588849390717;4132.73137246078;4161.854335098257;4174.415581818548;4180.28935081037;1324.5628942448968;1360.1974834847488;1360.6666366740212;1360.7958806179151;1360.931953402326;992.5880759484877;1022.1158697726413;1048.3343077145914;1073.6349641122056;1096.6381094238882;5913.615614985012;5963.4931030862;5978;6073.453389194905;6150.354212807681;489.60586727683847;494.6092586856415;496.1565338923844;499.92001279795784;504.20839282327125;4125.876223713293;4180.1848639515;4200.7059505834295;4208.263553878059;4250.298700714409;9834.655787047419;10198.541065652063;10287.43419111956;10293.794124117625;10296.382217067;9947.452890091114;10056.547455364525;10087.04173103554;10125.291229613857;10126.291159618757;7703.1526532081425;7835.6473958671995;7856.410769192334;7908.841823163504;7939.087004994384;5625.296837895263;5664.943350566442;5720.08478643415;5800.39095894925;5827.009408400498;9036.45781253127;9054.185123338932;9091.181793638605;9270.119338662817;9285.953570232106;9319.114684105;9495.097965693249;9502.23982081418;9502.572384242587;9511.286653501153;7908;7993.6003199838615;8105.554194519358;8281.420300578902;8446.944131983502;8322.916770832457;8352.457090289112;8383.077861435358;8408.873866892123;8411.53736544496;7374.225706300976;7553.773386798405;7571.962140189484;7610.9238907612435;7692.153863074946;7395.482316237812;7421.851562968603;7466.029416175862;7540.095188577406;7628.771136865903;7078.221395646372;7091.1490621125795;7139.892901606376;7140.571565706075;7155.463340249398;5070.188769796815;5110.821121260738;5180.818671346485;5200.843974680765;5258.579313654975;5219.947800522098;5221.060209162387;5268.604854635841;5335.306410166653;5344.946550534601 05:21:19 INFO - PROCESS | 20981 | |4;prototype.html;349.89503149055287;349.98600055997764;354.25606226923446;355.4508284700138;356.99107522311937;6102.755889764409;6147.385261473851;6193.783217587374;6204.100405441209;6205.503559715229;6075.270967483897;6083.48290395317;6083.878322433548;6084.330723620409;6112.266528016644;4464.866054018376;4518.344839998198;4647.721136731807;4653.860384188463;4657.347971284023;4604.608608268301;4622.838200662977;4632.4672662643725;4636.142313671965;4640.86077417678;4454.576815202567;4600.930986035212;4602.2406302960135;4605.217113090765;4609.262517997121;4529.456465224194;4564.338170965208;4574.153781550423;4664.603508701764;4665.300204969281;4115.54728979812;4122.855700050513;4125.793710314502;4129.793510324502;4130.958690413087;5874.9118763218585;5881.500072493843;5890.469857712784;5904.940950590482;5907.6160049597065;5400.486953739389;5405.459454054602;5406.243125962368;5409.540189083933;5414.702191379472;6363.5545511813725;6369.904451433232;6378.043293505965;6379.425851673325;6383.680815959184;4328.329108988112;4428.136513379892;4524.47968483622;4530.275155975061;4533.184026875161;6545.738170473175;6650.634215118166;6654.26803051664;6685.9665701671665;6699.899501507482;4522.186006518858;4540.614047805973;4545.954540454619;4547.567981041796;4548.931766023512;4575.542445755398;4592.10453961481;4592.770361481913;4596.218642830727;4597.3333866589155;5320.787168513216;5329.973350133225;5330.38700549434;5336.786528538815;5339.466053394707;6212.751489940442;6377.904331435032;6390.5526613136635;6454.806355809334;6464.159659244362;1566.3891082477842;1577.1798664694295;1577.7002369549748;1578.4712121439447;1581.2805173646193;1004.5931397783909;1047.0785708576404;1052.5894900988621;1065.868263473054;1068.1828401273033;6175.135481032659;6276.811695649138;6285.96857015712;6297.244330680348;6340.7463701451425;6724.361185687352;6726.630035348005;6727.697253623599;6727.730890764413;6736.023276624862;6303.432691057827;6314.336994615591;6317.715702793385;6322.367763223733;6332.366763323631;3562.5546806649168;3562.590302115238;3593.4609808528407;3603.6756691897854;3603.963960360415;6769.492288078413;6973.198082220508;6985.336393042653;7014.789556313319;7058.647067646597;6768.153980752406;6784.491163162783;6825.726970921207;6827.69275382609;6828.556143850733;6995;7013.614251216232;7026.508144429943;7027.61348125858;7028.683709233097;6687.398134167948;6704.430123439367;6705.698243578953;6708.83227919306;6716.83207919806;6470.352964703492;6476.579022363531;6584.308647591934;6591.406773390226;6598.307177746267;6982.371586557234;6998.580085194904;7006.649667516502;7009.088818453569;7020.684069217;4578.153041687298;4581.816727331003;4582.33556134352;4585.12882552314;4588.357629931879;6680.5991640501725;6681.799546013627;6689.09697190873;6697.229818570732;6699.229588597179;6323.399277068671;6457.418832305115;6467.353264673495;6481.287058423475;6486.189226346707;6363.96818015907;6451.967740161269;6455.838604034937;6463.15978922737;6464.0627109069865;6312.747490100344;6335.081413195153;6356.4279214870885;6360.332165122595;6363.522735794926;6507.804765857032;6513.5114866384265;6515.087887695821;6522.15212022434;6523.543351965317;6020.518358531394;6195.845103872439;6347.873042539216;6359.523035772429;6367.458766004941 05:21:19 INFO - PROCESS | 20981 | |5;yui.html;837.1670188162777;865.7143142762889;926.1340646495523;936.5879013234172;948.7675519497724;14212;14457.0602910811;14487.348069336878;14524;16997.2351244194;15089.547313580582;15089.54731358061;15093.169875656835;15156.469523566677;15171.620709482268;724.6449239872451;872.5724395046414;887.4054383563013;897.9551022448884;909.9727008189765;912.16536868765;912.4160537256129;915.450729562264;915.7664795477144;915.9679411220609;975.5073687787657;978.6525783346916;979.5298256836722;980.9901900981006;982.9017098290185;758.5789886612928;939.5255396024997;946.0444950599875;947.209080417852;948.1182500274776;694.1531331775226;694.7047504810436;694.8540806430656;695.4853408477741;695.5965539986795;15366.231688415535;15743.291551880193;15754.606134846606;15768.290426930816;15772.842271577252;14586.416543338253;14799.260036998216;14825.55523334291;14874.405023799036;15263;12159.574414895436;12263;12300.75398492034;12352.197107188094;12561.120721549496;4522.276435770261;4574.794134263932;4577.450705915278;4623.606993405565;4648.767561621939;54089.729551352386;54377;54621.453785462036;54888.176677349875;55162.72418637881;10933.070688991525;11066.225364224589;11073.114150867912;11084.556617735201;11287.604933827277;20083.59832803365;20174.89912550428;20196.596068078557;20229.08969096394;20294.594108117755;8597.914020859836;8715.564221789013;8778.648854045767;8833.249173820168;8998.14517620825;5021.824236151717;5052.9242061369105;5107.974460127675;5120.283160357553;5220.034293655686;3624.05774498627;3677.0439685681918;3686.170611612366;3694.8152592370275;3697.7411581189594;610.6702380714453;642.1651852591613;664.3821246241042;752.0636807175102;757.1822431773782;794.4200733464488;809.5304723260494;815.0993152566447;825.1665817524224;847.9618417171242;9547.331686781998;9613.327067105376;9737.610495580097;9775.120239178508;9785.168260697777;708.674009955416;726.9273072692688;735.0627949364496;790.3795520516367;834.9624266908004;4380.123975204971;4551.2717965126085;4588;4665.790039448233;4669.369635099286;66999.33000669931;67653;67814.66092669604;67948.32051679518;68569;58936.70531647314;60829.69585152046;61091.08363374553;61287;61422;53434.73282633562;54041.459585403645;54639.45360546344;55116;55215.447845521834;8955.910440895508;9233.861492077758;9239.72280831576;9284.72145835626;9285;39404.21191576095;40305.38015029014;41347.379789302584;41400.37899431571;41985.58014419939;45626.77186614046;45824.770876145405;49367.506324936294;51550;52694.73652631712;11249.268797528135;11486.655400338002;11640.185187037165;11668.124890633406;11762.235454695418;12856.485740570273;12917.806232906702;13226.338683066;13269.535566255136;13386.26375549354;12797;12805.295708736108;13101.017423693453;13201.735965280832;13575.932120339336;11961.342126182795;12029.699257518632;12147.392630368622;12284.631461056182;12375.504979800708;11936.462859171184;12009.399530023638;12014.098942579516;12158.574449894211;12185.268883866996;10092.949535252277;10250.794984100425;10273.537690804082;10401.791964160826;10498.212634052325;9980.800383992135;10145.594176232868;10341.63804266847;10343.94828025855;10383.94808025955 05:21:19 INFO - PROCESS | 20981 | __end_tp_report 05:21:19 INFO - PROCESS | 20981 | __start_cc_report 05:21:19 INFO - PROCESS | 20981 | _x_x_mozilla_cycle_collect,771 05:21:19 INFO - PROCESS | 20981 | __end_cc_report 05:21:19 INFO - PROCESS | 20981 | __startTimestamp1467980479000__endTimestamp 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - PROCESS | 20981 | ------- Summary: start ------- 05:21:19 INFO - PROCESS | 20981 | Number of tests: 6 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - PROCESS | 20981 | [#0] dojo.html Cycles:165 Average:5475.76 Median:5713.20 stddev:610.19 (10.7%) stddev-sans-first:586.99 05:21:19 INFO - PROCESS | 20981 | Values: 3269.0 3343.8 3346.9 3376.4 3380.9 5471.6 5487.7 5506.4 5514.7 5526.8 5478.4 5529.3 5532.6 5534.3 5571.7 4944.1 4959.9 5036.4 5083.5 5107.0 4882.9 4967.6 4975.4 4998.9 5005.4 4965.9 4970.6 4994.6 5020.8 5062.7 5030.5 5064.5 5078.4 5079.2 5108.3 4928.8 4933.8 4981.2 4985.9 4995.2 5381.6 5400.6 5401.8 5403.3 5405.5 5676.4 5718.7 5720.9 5723.1 5737.9 5817.4 5889.2 5983.1 6026.2 6044.2 5421.2 5455.6 5473.3 5483.7 5522.2 5858.0 5972.7 5974.2 5974.4 5977.4 5761.3 5821.7 5836.6 5837.0 5838.6 5906.4 5907.5 5918.3 5920.6 5921.7 5713.2 5792.4 5879.8 5884.0 5885.3 5879.1 5892.6 5896.2 5896.4 5927.9 4508.3 4518.8 4519.5 4521.4 4544.6 3972.9 3987.4 4021.3 4024.8 4066.2 5515.1 5578.3 5604.4 5613.5 5619.0 5882.1 5893.4 5894.8 5895.8 5904.4 5482.5 5517.8 5564.4 5628.2 5639.3 5006.5 5014.5 5034.2 5036.6 5037.6 6163.1 6179.2 6181.1 6185.7 6193.3 5724.4 5899.9 5908.6 5987.1 6022.3 6176.9 6186.7 6213.2 6217.0 6230.4 5830.1 5834.4 5836.7 5844.0 5845.4 5725.4 5919.1 5921.2 6005.5 6021.2 5739.8 5787.8 5790.8 5802.5 5810.4 5722.0 5755.2 5774.1 5779.4 5785.9 5501.3 5627.7 5639.3 5674.4 5721.3 5790.2 5814.7 5834.0 5838.2 5845.1 5510.9 5701.6 5713.9 5716.2 5732.5 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - PROCESS | 20981 | [#1] ext.html Cycles:180 Average:52917.66 Median:34955.32 stddev:92186.14 (263.7%) stddev-sans-first:92361.08 05:21:19 INFO - PROCESS | 20981 | Values: 608.0 660.9 672.7 686.7 695.2 31872.0 32547.2 39925.8 40845.0 40855.4 44722.0 45469.5 45540.0 45556.5 45564.8 7692.6 8945.6 9124.0 9124.6 10515.1 10616.2 10752.3 10753.8 10755.8 10761.2 10768.0 10821.5 10832.9 10838.2 10840.8 10651.3 10721.7 10726.9 10728.7 10729.5 10634.5 10763.0 10776.1 11055.3 11066.7 44289.1 44376.8 44780.3 44835.8 44865.3 3869.3 4276.3 4390.5 4527.1 4622.8 34037.7 35071.6 35688.5 36565.0 37014.6 4519.7 4564.0 4729.1 4771.9 4814.5 224102.0 226207.0 226262.0 227009.0 227446.0 60036.7 60161.0 60531.0 60617.4 60664.4 72889.0 74584.6 74613.0 74631.3 74632.3 18839.3 18991.8 19023.0 19059.8 19062.7 13509.6 14633.1 14728.1 15085.2 15140.4 20646.6 20819.0 20842.1 20849.4 20855.4 7509.9 7528.2 7586.7 7740.8 7830.2 1136.2 1176.9 1182.9 1225.6 1283.6 33777.5 34370.5 34418.3 34631.5 34764.3 1214.6 1260.9 1268.6 1275.1 1324.7 17612.8 17852.8 17921.1 17948.2 18314.5 474560.0 476582.0 480588.0 480772.0 481577.0 64147.4 64847.4 65098.7 65237.3 65288.7 1415.5 1458.3 1541.4 1573.1 1674.5 31587.7 33062.3 33249.0 33826.2 33830.7 51296.5 51716.7 51831.5 51881.7 51904.2 291751.0 292295.0 293611.0 293867.0 294131.0 28714.1 28769.0 28840.0 30904.7 31339.0 51585.0 52053.0 52578.5 52818.2 54519.5 42587.0 43302.8 43843.6 44354.3 44815.0 42717.4 42913.0 43565.8 43934.8 44228.8 45008.8 45345.3 46058.0 46687.3 47061.1 33290.7 34839.0 35283.8 35973.5 36019.3 27303.7 28289.3 28738.6 29118.6 29119.4 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - PROCESS | 20981 | [#2] jquery.html Cycles:180 Average:29307.88 Median:2079.66 stddev:83543.57 (4017.2%) stddev-sans-first:83749.79 05:21:19 INFO - PROCESS | 20981 | Values: 429.3 430.0 432.4 436.4 442.6 18719.3 18843.0 19203.0 19289.2 19469.3 18539.0 18716.9 19422.9 19512.2 19512.5 5425.5 5672.9 5832.2 5841.9 5847.6 4201.4 5756.3 5808.1 6202.1 6501.8 6475.2 6485.5 6497.0 6499.9 6503.6 5561.3 5802.3 5815.9 5818.1 6426.0 3858.9 3975.5 5490.4 5662.3 5671.5 14019.2 14214.9 14225.1 14240.3 20936.5 2435.0 2514.8 2518.7 2533.8 2829.9 10056.8 10204.3 10234.4 10260.5 10314.8 1932.1 1943.5 2020.5 2092.6 2136.0 77564.6 80853.0 80901.6 81221.6 81657.2 11164.0 11345.3 11355.7 11452.0 11669.3 15774.8 15806.7 15937.2 15946.2 15950.6 8451.5 8634.6 8983.1 9010.8 9078.7 8920.2 8925.9 8996.3 9039.9 9062.4 4686.7 4717.1 4809.6 4916.5 4929.9 1805.5 2021.8 2066.3 2079.6 2079.8 1032.3 1118.3 1122.4 1123.5 1144.6 17024.7 18640.7 18942.9 18990.8 19067.1 1074.6 1084.8 1090.4 1091.5 1102.4 10264.3 10749.8 10890.4 10892.2 11034.8 473059.0 489444.0 504743.0 528828.0 538832.0 88556.1 90824.0 91204.9 91791.0 94155.0 1046.9 1048.9 1124.1 1146.3 1150.5 16830.2 16959.0 17067.0 17085.5 17172.7 38350.2 38576.2 40295.6 40403.2 40616.6 54611.5 57054.7 57719.4 57941.0 57946.0 9014.3 9159.7 9236.0 9245.4 9253.2 12778.9 13837.9 13987.9 14000.6 14042.7 11698.6 11842.2 12129.5 12308.6 12363.7 11675.6 11715.1 11774.8 11904.2 11910.4 12141.8 12465.7 12491.8 12506.7 12587.2 8932.0 8949.9 9011.5 9086.3 9250.3 11795.8 11969.3 12112.6 12123.2 12538.8 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - PROCESS | 20981 | [#3] mootools.html Cycles:180 Average:5707.29 Median:5047.33 stddev:3111.01 (61.6%) stddev-sans-first:3103.05 05:21:19 INFO - PROCESS | 20981 | Values: 1419.0 1615.0 1616.1 1854.7 1956.4 8199.3 8448.0 8449.3 8452.4 8462.2 8305.8 8483.5 8485.3 8490.9 8503.9 2402.9 2428.8 2429.4 2433.6 2436.2 2356.7 2413.0 2443.7 2445.5 2448.8 2388.8 2402.7 2410.7 2458.5 2459.3 2331.8 2364.7 2382.5 2395.4 2398.4 2373.1 2424.2 2438.2 2438.8 2441.0 7319.2 7489.1 8685.0 8707.6 8726.5 5107.7 5204.1 5206.8 5207.5 5208.2 3556.8 3557.3 3609.1 3646.5 3665.0 1153.5 1188.9 1191.3 1212.8 1263.2 12008.3 12096.9 12155.0 12203.7 12209.4 4660.0 4727.6 4730.9 4760.2 4862.6 10401.4 10431.9 10451.9 10452.9 10456.2 5458.2 5504.3 5512.7 5514.5 5516.6 4934.6 5029.3 5046.0 5047.1 5047.5 4031.9 4132.7 4161.9 4174.4 4180.3 1324.6 1360.2 1360.7 1360.8 1360.9 992.6 1022.1 1048.3 1073.6 1096.6 5913.6 5963.5 5978.0 6073.5 6150.4 489.6 494.6 496.2 499.9 504.2 4125.9 4180.2 4200.7 4208.3 4250.3 9834.7 10198.5 10287.4 10293.8 10296.4 9947.5 10056.5 10087.0 10125.3 10126.3 7703.2 7835.6 7856.4 7908.8 7939.1 5625.3 5664.9 5720.1 5800.4 5827.0 9036.5 9054.2 9091.2 9270.1 9286.0 9319.1 9495.1 9502.2 9502.6 9511.3 7908.0 7993.6 8105.6 8281.4 8446.9 8322.9 8352.5 8383.1 8408.9 8411.5 7374.2 7553.8 7572.0 7610.9 7692.2 7395.5 7421.9 7466.0 7540.1 7628.8 7078.2 7091.1 7139.9 7140.6 7155.5 5070.2 5110.8 5180.8 5200.8 5258.6 5219.9 5221.1 5268.6 5335.3 5344.9 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - PROCESS | 20981 | [#4] prototype.html Cycles:180 Average:5405.69 Median:6199.97 stddev:1646.14 (26.6%) stddev-sans-first:1606.42 05:21:19 INFO - PROCESS | 20981 | Values: 349.9 350.0 354.3 355.5 357.0 6102.8 6147.4 6193.8 6204.1 6205.5 6075.3 6083.5 6083.9 6084.3 6112.3 4464.9 4518.3 4647.7 4653.9 4657.3 4604.6 4622.8 4632.5 4636.1 4640.9 4454.6 4600.9 4602.2 4605.2 4609.3 4529.5 4564.3 4574.2 4664.6 4665.3 4115.5 4122.9 4125.8 4129.8 4131.0 5874.9 5881.5 5890.5 5904.9 5907.6 5400.5 5405.5 5406.2 5409.5 5414.7 6363.6 6369.9 6378.0 6379.4 6383.7 4328.3 4428.1 4524.5 4530.3 4533.2 6545.7 6650.6 6654.3 6686.0 6699.9 4522.2 4540.6 4546.0 4547.6 4548.9 4575.5 4592.1 4592.8 4596.2 4597.3 5320.8 5330.0 5330.4 5336.8 5339.5 6212.8 6377.9 6390.6 6454.8 6464.2 1566.4 1577.2 1577.7 1578.5 1581.3 1004.6 1047.1 1052.6 1065.9 1068.2 6175.1 6276.8 6286.0 6297.2 6340.7 6724.4 6726.6 6727.7 6727.7 6736.0 6303.4 6314.3 6317.7 6322.4 6332.4 3562.6 3562.6 3593.5 3603.7 3604.0 6769.5 6973.2 6985.3 7014.8 7058.6 6768.2 6784.5 6825.7 6827.7 6828.6 6995.0 7013.6 7026.5 7027.6 7028.7 6687.4 6704.4 6705.7 6708.8 6716.8 6470.4 6476.6 6584.3 6591.4 6598.3 6982.4 6998.6 7006.6 7009.1 7020.7 4578.2 4581.8 4582.3 4585.1 4588.4 6680.6 6681.8 6689.1 6697.2 6699.2 6323.4 6457.4 6467.4 6481.3 6486.2 6364.0 6452.0 6455.8 6463.2 6464.1 6312.7 6335.1 6356.4 6360.3 6363.5 6507.8 6513.5 6515.1 6522.2 6523.5 6020.5 6195.8 6347.9 6359.5 6367.5 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - PROCESS | 20981 | [#5] yui.html Cycles:180 Average:15762.14 Median:27018.44 stddev:18539.80 (68.6%) stddev-sans-first:18557.93 05:21:19 INFO - PROCESS | 20981 | Values: 837.2 865.7 926.1 936.6 948.8 14212.0 14457.1 14487.3 14524.0 16997.2 15089.5 15089.5 15093.2 15156.5 15171.6 724.6 872.6 887.4 898.0 910.0 912.2 912.4 915.5 915.8 916.0 975.5 978.7 979.5 981.0 982.9 758.6 939.5 946.0 947.2 948.1 694.2 694.7 694.9 695.5 695.6 15366.2 15743.3 15754.6 15768.3 15772.8 14586.4 14799.3 14825.6 14874.4 15263.0 12159.6 12263.0 12300.8 12352.2 12561.1 4522.3 4574.8 4577.5 4623.6 4648.8 54089.7 54377.0 54621.5 54888.2 55162.7 10933.1 11066.2 11073.1 11084.6 11287.6 20083.6 20174.9 20196.6 20229.1 20294.6 8597.9 8715.6 8778.6 8833.2 8998.1 5021.8 5052.9 5108.0 5120.3 5220.0 3624.1 3677.0 3686.2 3694.8 3697.7 610.7 642.2 664.4 752.1 757.2 794.4 809.5 815.1 825.2 848.0 9547.3 9613.3 9737.6 9775.1 9785.2 708.7 726.9 735.1 790.4 835.0 4380.1 4551.3 4588.0 4665.8 4669.4 66999.3 67653.0 67814.7 67948.3 68569.0 58936.7 60829.7 61091.1 61287.0 61422.0 53434.7 54041.5 54639.5 55116.0 55215.4 8955.9 9233.9 9239.7 9284.7 9285.0 39404.2 40305.4 41347.4 41400.4 41985.6 45626.8 45824.8 49367.5 51550.0 52694.7 11249.3 11486.7 11640.2 11668.1 11762.2 12856.5 12917.8 13226.3 13269.5 13386.3 12797.0 12805.3 13101.0 13201.7 13575.9 11961.3 12029.7 12147.4 12284.6 12375.5 11936.5 12009.4 12014.1 12158.6 12185.3 10092.9 10250.8 10273.5 10401.8 10498.2 9980.8 10145.6 10341.6 10343.9 10383.9 05:21:19 INFO - PROCESS | 20981 | -------- Summary: end -------- 05:21:19 INFO - PROCESS | 20981 | 05:21:19 INFO - TEST-INFO | 20981: exit 0 05:21:19 INFO - TEST-OK | dromaeo_css | took 1110119ms 05:21:19 INFO - TEST-START | kraken 05:21:19 INFO - operating with platform_type : linux_ 05:21:19 INFO - Initialising browser for kraken test... 05:21:19 INFO - TEST-INFO | started process 21180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTP4Qh8/profile http://localhost:49171/getInfo.html) 05:21:23 INFO - PROCESS | 21180 | __metrics Screen width/height:1600/1200 05:21:23 INFO - PROCESS | 21180 | colorDepth:24 05:21:23 INFO - PROCESS | 21180 | Browser inner width/height: 1024/697 05:21:23 INFO - PROCESS | 21180 | __metrics 05:21:24 ERROR - PROCESS | 21180 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:21:24 INFO - TEST-INFO | 21180: exit 0 05:21:24 INFO - Browser initialized. 05:21:24 INFO - Running cycle 1/1 for kraken test... 05:21:24 INFO - TEST-INFO | started process 21272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTP4Qh8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:36 INFO - PROCESS | 21272 | RSS: Main: 139542528 05:21:36 INFO - PROCESS | 21272 | 05:21:39 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49171/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:39 INFO - PROCESS | 21272 | RSS: Main: 198139904 05:21:39 INFO - PROCESS | 21272 | 05:21:42 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49171/tests/kraken/driver.html?testName=audio-dft) 05:21:43 INFO - PROCESS | 21272 | RSS: Main: 184545280 05:21:43 INFO - PROCESS | 21272 | 05:21:46 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49171/tests/kraken/driver.html?testName=audio-fft) 05:21:46 INFO - PROCESS | 21272 | RSS: Main: 273203200 05:21:46 INFO - PROCESS | 21272 | 05:21:48 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49171/tests/kraken/driver.html?testName=audio-oscillator) 05:21:49 INFO - PROCESS | 21272 | RSS: Main: 180465664 05:21:49 INFO - PROCESS | 21272 | 05:21:51 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:52 INFO - PROCESS | 21272 | RSS: Main: 178659328 05:21:52 INFO - PROCESS | 21272 | 05:21:55 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49171/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:55 INFO - PROCESS | 21272 | RSS: Main: 213241856 05:21:55 INFO - PROCESS | 21272 | 05:21:59 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49171/tests/kraken/driver.html?testName=imaging-desaturate) 05:21:59 INFO - PROCESS | 21272 | RSS: Main: 213610496 05:21:59 INFO - PROCESS | 21272 | 05:22:02 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49171/tests/kraken/driver.html?testName=json-parse-financial) 05:22:02 INFO - PROCESS | 21272 | RSS: Main: 212369408 05:22:02 INFO - PROCESS | 21272 | 05:22:04 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:04 INFO - PROCESS | 21272 | RSS: Main: 194224128 05:22:05 INFO - PROCESS | 21272 | 05:22:06 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49171/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:07 INFO - PROCESS | 21272 | RSS: Main: 197648384 05:22:07 INFO - PROCESS | 21272 | 05:22:09 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:09 INFO - PROCESS | 21272 | RSS: Main: 209063936 05:22:09 INFO - PROCESS | 21272 | 05:22:12 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:12 INFO - PROCESS | 21272 | RSS: Main: 218161152 05:22:12 INFO - PROCESS | 21272 | 05:22:15 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:16 INFO - PROCESS | 21272 | RSS: Main: 214781952 05:22:16 INFO - PROCESS | 21272 | 05:22:17 INFO - PROCESS | 21272 | Cycle 1(1): loaded http://localhost:49171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49171/tests/kraken/driver.html?testName=ai-astar) 05:22:18 INFO - PROCESS | 21272 | RSS: Main: 275668992 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | __start_tp_report 05:22:18 INFO - PROCESS | 21272 | _x_x_mozilla_page_load 05:22:18 INFO - PROCESS | 21272 | _x_x_mozilla_page_load_details 05:22:18 INFO - PROCESS | 21272 | |i|pagename|runs| 05:22:18 INFO - PROCESS | 21272 | |0;ai-astar;110;109;109;109;110;110;104;110;110;109 05:22:18 INFO - PROCESS | 21272 | |1;audio-beat-detection;156;125;156;194;125;151;153;130;189;126 05:22:18 INFO - PROCESS | 21272 | |2;audio-dft;160;159;160;161;164;161;161;160;160;161 05:22:18 INFO - PROCESS | 21272 | |3;audio-fft;76;75;75;172;78;75;74;76;159;73 05:22:18 INFO - PROCESS | 21272 | |4;audio-oscillator;92;92;147;91;91;92;143;91;90;148 05:22:18 INFO - PROCESS | 21272 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;116;117;117 05:22:18 INFO - PROCESS | 21272 | |6;imaging-darkroom;145;145;146;145;145;145;145;146;145;146 05:22:18 INFO - PROCESS | 21272 | |7;imaging-desaturate;94;95;95;94;95;95;96;95;94;94 05:22:18 INFO - PROCESS | 21272 | |8;json-parse-financial;59;53;53;53;52;53;53;72;51;52 05:22:18 INFO - PROCESS | 21272 | |9;json-stringify-tinderbox;56;58;56;57;57;57;57;57;58;58 05:22:18 INFO - PROCESS | 21272 | |10;stanford-crypto-aes;71;72;87;71;73;73;73;73;80;73 05:22:18 INFO - PROCESS | 21272 | |11;stanford-crypto-ccm;115;113;126;113;113;109;130;115;130;129 05:22:18 INFO - PROCESS | 21272 | |12;stanford-crypto-pbkdf2;160;165;158;166;171;161;163;163;159;160 05:22:18 INFO - PROCESS | 21272 | |13;stanford-crypto-sha256-iterative;67;68;68;66;66;67;67;67;67;66 05:22:18 INFO - PROCESS | 21272 | __end_tp_report 05:22:18 INFO - PROCESS | 21272 | __start_cc_report 05:22:18 INFO - PROCESS | 21272 | _x_x_mozilla_cycle_collect,1596 05:22:18 INFO - PROCESS | 21272 | __end_cc_report 05:22:18 INFO - PROCESS | 21272 | __startTimestamp1467980538182__endTimestamp 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | ------- Summary: start ------- 05:22:18 INFO - PROCESS | 21272 | Number of tests: 14 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:1.83 (1.7%) stddev-sans-first:1.90 05:22:18 INFO - PROCESS | 21272 | Values: 110.0 109.0 109.0 109.0 110.0 110.0 104.0 110.0 110.0 109.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:154.50 stddev:25.30 (16.4%) stddev-sans-first:26.76 05:22:18 INFO - PROCESS | 21272 | Values: 156.0 125.0 156.0 194.0 125.0 151.0 153.0 130.0 189.0 126.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 05:22:18 INFO - PROCESS | 21272 | Values: 160.0 159.0 160.0 161.0 164.0 161.0 161.0 160.0 160.0 161.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.00 stddev:38.20 (50.9%) stddev-sans-first:40.00 05:22:18 INFO - PROCESS | 21272 | Values: 76.0 75.0 75.0 172.0 78.0 75.0 74.0 76.0 159.0 73.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:91.00 stddev:26.47 (29.1%) stddev-sans-first:27.46 05:22:18 INFO - PROCESS | 21272 | Values: 92.0 92.0 147.0 91.0 91.0 92.0 143.0 91.0 90.0 148.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:22:18 INFO - PROCESS | 21272 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:22:18 INFO - PROCESS | 21272 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:22:18 INFO - PROCESS | 21272 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 94.0 94.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:53.00 stddev:6.31 (11.9%) stddev-sans-first:6.54 05:22:18 INFO - PROCESS | 21272 | Values: 59.0 53.0 53.0 53.0 52.0 53.0 53.0 72.0 51.0 52.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 05:22:18 INFO - PROCESS | 21272 | Values: 56.0 58.0 56.0 57.0 57.0 57.0 57.0 57.0 58.0 58.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:73.00 stddev:5.04 (6.9%) stddev-sans-first:5.17 05:22:18 INFO - PROCESS | 21272 | Values: 71.0 72.0 87.0 71.0 73.0 73.0 73.0 73.0 80.0 73.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:120.50 stddev:8.37 (6.9%) stddev-sans-first:8.73 05:22:18 INFO - PROCESS | 21272 | Values: 115.0 113.0 126.0 113.0 113.0 109.0 130.0 115.0 130.0 129.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:3.92 (2.4%) stddev-sans-first:4.04 05:22:18 INFO - PROCESS | 21272 | Values: 160.0 165.0 158.0 166.0 171.0 161.0 163.0 163.0 159.0 160.0 05:22:18 INFO - PROCESS | 21272 | 05:22:18 INFO - PROCESS | 21272 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 05:22:18 INFO - PROCESS | 21272 | Values: 67.0 68.0 68.0 66.0 66.0 67.0 67.0 67.0 67.0 66.0 05:22:18 INFO - PROCESS | 21272 | -------- Summary: end -------- 05:22:18 INFO - PROCESS | 21272 | 05:22:19 INFO - TEST-INFO | 21272: exit 0 05:22:19 INFO - TEST-OK | kraken | took 59423ms 05:22:19 INFO - SUITE-END | took 1169s 05:22:19 INFO - Completed test suite (00:19:29) 05:22:19 INFO - javascript benchmark 05:22:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.9509657355143, 3343.799372037678, 3346.899593012209, 3376.35849188654, 3380.9492857607124, 5471.562275017999, 5487.725613719313, 5506.366767821702, 5514.724263786815, 5526.834194974147, 5478.369987451444, 5529.30883639545, 5532.612717109804, 5534.308211473556, 5571.749271282792, 4944.085344211315, 4959.876003099925, 5036.395632524102, 5083.517065878736, 5107.029664363759, 4882.853514394574, 4967.577755890754, 4975.402951645808, 4998.875028124289, 5005.374328208974, 4965.925511117336, 4970.552650261476, 4994.550490455858, 5020.799168033274, 5062.721550314731, 5030.471800460954, 5064.493550644943, 5078.390593128848, 5079.187330027215, 5108.310378098946, 4928.778204980785, 4933.827316043958, 4981.227909674007, 4985.925211121836, 4995.200767877122, 5381.623286369956, 5400.567954563626, 5401.78392864285, 5403.297571315704, 5405.5135037846785, 5676.375598684142, 5718.742656580423, 5720.856978575569, 5723.141528770676, 5737.942620573783, 5817.389174136697, 5889.204957330749, 5983.132445795379, 6026.2165918430765, 6044.1840351552855, 5421.186821976696, 5455.645383050089, 5473.28847249855, 5483.698396588186, 5522.22688823565, 5858.0, 5972.701364931736, 5974.2233509643465, 5974.402559744078, 5977.402259773988, 5761.251037365116, 5821.7380217890295, 5836.591438599342, 5837.0, 5838.649681019152, 5906.40935906406, 5907.4683278505145, 5918.2898052234, 5920.615160014585, 5921.703914804329, 5713.200151978726, 5792.4497172768515, 5879.823605291848, 5883.970580147072, 5885.323187833454, 5879.088741245114, 5892.646441213541, 5896.174535565025, 5896.439838215363, 5927.881442371215, 4508.323751437245, 4518.841840535565, 4519.480259770103, 4521.3896124023495, 4544.636429085665, 3972.920541589152, 3987.3620220764537, 4021.2761702893176, 4024.7987600619854, 4066.2274167908004, 5515.117581186991, 5578.330600327987, 5604.355499117572, 5613.522850557748, 5618.971905140448, 5882.117682347596, 5893.381194974551, 5894.823155305347, 5895.764169433261, 5904.439078287556, 5482.479164479368, 5517.806876759294, 5564.443555644484, 5628.183913332544, 5639.295088113986, 5006.549410553068, 5014.52362025607, 5034.169362055293, 5036.5718913892, 5037.647364684437, 6163.075538669146, 6179.16581261533, 6181.103739957681, 6185.721642526007, 6193.256809182837, 5724.370319264961, 5899.882002359929, 5908.645481271137, 5987.101934709654, 6022.277326720821, 6176.907346389898, 6186.659733714689, 6213.2233470816145, 6216.974199257072, 6230.43926046658, 5830.096335068071, 5834.445727655866, 5836.678982655994, 5843.970780146072, 5845.3570107289015, 5725.427457254241, 5919.052951527735, 5921.2006379138265, 6005.459508644243, 6021.157038014769, 5739.770409183586, 5787.826365209051, 5790.7973220937065, 5802.535797136304, 5810.360860305447, 5721.971390143022, 5755.1942728017275, 5774.0761478163295, 5779.422057794187, 5785.884282314246, 5501.284832971688, 5627.662340259598, 5639.3232812062815, 5674.404187560247, 5721.284839395075, 5790.1893734877995, 5814.680192589448, 5834.03738383179, 5838.211841401527, 5845.064789633639, 5510.889782204414, 5701.600887937804, 5713.857153571194, 5716.199732037435, 5732.512736417451], "value": 5436.276591399484, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.9848003799905, 660.867826434713, 672.6569449580712, 686.6909890549254, 695.1970474102413, 31872.0, 32547.186320342003, 39925.80037099818, 40845.0, 40855.387169192414, 44722.0, 45469.54530454695, 45540.0, 45556.544434555646, 45564.77217613916, 7692.615369231544, 8945.552722363873, 9124.0, 9124.58939347731, 10515.106215971651, 10616.20378471614, 10752.301100428485, 10753.78492430151, 10755.784884302348, 10761.246712730112, 10768.030877221048, 10821.458927053616, 10832.891671083307, 10838.187135964794, 10840.837387439195, 10651.25441219115, 10721.731956701067, 10726.946365268124, 10728.678139655824, 10729.517171727291, 10634.521446534924, 10763.031327180592, 10776.137908967265, 11055.336679799238, 11066.723331916686, 44289.11421771579, 44376.77811610953, 44780.3282950756, 44835.77582112069, 44865.32702009472, 3869.303525365433, 4276.294411422112, 4390.4511936008, 4527.094581083797, 4622.8382006629945, 34037.6596234037, 35071.64928350735, 35688.46467302993, 36565.0, 37014.629853701656, 4519.683622146451, 4563.977180114111, 4729.148753224418, 4771.928431002644, 4814.470408255089, 224102.0, 226206.99999999834, 226262.0, 227009.0, 227446.0, 60036.69981650151, 60161.0, 60531.0, 60617.393826062056, 60664.39335606588, 72889.0, 74584.62707686427, 74613.0, 74631.25368746243, 74632.25367746253, 18839.340623078126, 18991.810081899002, 19023.048847557566, 19059.80940190608, 19062.714059289123, 13509.59471215865, 14633.122012679274, 14728.116313021254, 15085.170315632526, 15140.394384224508, 20646.587068258552, 20819.0, 20842.062107205213, 20849.374518764158, 20855.37433876986, 7509.924900751032, 7528.209537998431, 7586.696532138652, 7740.8451830964195, 7830.216978302238, 1136.2387200575633, 1176.9348739390864, 1182.8639706433698, 1225.5587988324196, 1283.6277479531018, 33777.49333759995, 34370.48444273338, 34418.31163376718, 34631.480527792104, 34764.30471390558, 1214.5809695654984, 1260.9180403273758, 1268.6384380451527, 1275.1265383212528, 1324.72843067171, 17612.823871761117, 17852.821471785377, 17921.103944802708, 17948.192331345123, 18314.542136446697, 474560.0, 476582.0, 480588.0, 480772.0, 481577.0, 64147.358526415075, 64847.35152648507, 65098.674506628115, 65237.347626524075, 65288.673556632864, 1415.469199050356, 1458.3000159923297, 1541.368039103962, 1573.1190533301387, 1674.4809109176194, 31587.684123158473, 33062.33875322432, 33249.0, 33826.15434614154, 33830.661693383736, 51296.48703512917, 51716.74141629268, 51831.48168518267, 51881.7405912968, 51904.221436677726, 291751.0, 292295.0, 293611.0, 293867.0, 294131.0, 28714.138575842757, 28769.0, 28840.0, 30904.69095309108, 31339.0, 51585.0, 52053.0, 52578.47421525736, 52818.20772688336, 54519.45480545144, 42587.0, 43302.78348608237, 43843.56156438395, 44354.33468498039, 44815.0, 42717.35923961205, 42913.0, 43565.78217108894, 43934.78032609817, 44228.77885610551, 45008.77495612501, 45345.319820202065, 46058.0, 46687.29969050399, 47061.05877882492, 33290.66709332875, 34839.0, 35283.82358088193, 35973.46039809353, 36019.279614408086, 27303.726962730914, 28289.292767680974, 28738.568921465776, 29118.56322155127, 29119.417611647226], "value": 21256.874403375103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.3452484960436, 429.9806508707108, 432.3816941773263, 436.4435344935207, 442.59060369158533, 18719.3448229312, 18843.0, 19203.0, 19289.22843086275, 19469.31857384992, 18539.0, 18716.906415467904, 19422.90288548559, 19512.219511219533, 19512.512187195327, 5425.538829199503, 5672.886542269162, 5832.1834943108, 5841.853953651172, 5847.649141051551, 4201.390798334255, 5756.338021127561, 5808.12878068289, 6202.131701561785, 6501.7724379646725, 6475.158229430168, 6485.546011779177, 6497.0, 6499.870002599945, 6503.577267477623, 5561.332640083196, 5802.274715660543, 5815.883682326372, 5818.1272809078555, 6426.0, 3858.9421158682644, 3975.463312452811, 5490.423505531941, 5662.320521537442, 5671.517920976722, 14019.158850468903, 14214.928925355307, 14225.07537010091, 14240.287985600782, 20936.47658808527, 2434.9878250608635, 2514.7610976957158, 2518.7103483099313, 2533.7972962163167, 2829.9434011319863, 10056.798864022678, 10204.336718113298, 10234.385936843813, 10260.486975651187, 10314.793704125876, 1932.1498540642071, 1943.504406376365, 2020.4847763820278, 2092.550101728136, 2136.0174319812904, 77564.61217693875, 80853.0, 80901.59549202275, 81221.59389203075, 81657.18342816555, 11164.0, 11345.319280843176, 11355.659330220107, 11452.0, 11669.299842009337, 15774.842251577338, 15806.68386632261, 15937.167225768953, 15946.20268986546, 15950.601234968986, 8451.492910425393, 8634.56827158652, 8983.056779038237, 9010.819783604291, 9078.682246121354, 8920.152585504367, 8925.910740892508, 8996.325275604357, 9039.909600904039, 9062.410943288665, 4686.671932964728, 4717.127331443694, 4809.615230781599, 4916.483769204182, 4929.876753081202, 1805.4506761858954, 2021.777604463508, 2066.338771593106, 2079.55157487381, 2079.760827504826, 1032.339302846179, 1118.2675347647305, 1122.3602546548389, 1123.5449642894641, 1144.5707859552667, 17024.744628830576, 18640.72038919417, 18942.905285473484, 18990.81009189918, 19067.141978610995, 1074.55406006508, 1084.7776205877776, 1090.4057288777635, 1091.4870011094772, 1102.3826657072066, 10264.281500295057, 10749.785004300027, 10890.401027943539, 10892.183086268404, 11034.779304414027, 473059.0, 489444.0, 504743.0, 528828.0, 538832.0, 88556.11443885608, 90824.0, 91204.88103473275, 91791.0, 94155.0, 1046.8902962859393, 1048.8846226915034, 1124.0501775999267, 1146.340854008948, 1150.511032811052, 16830.158492075592, 16959.0, 17067.0, 17085.48743537696, 17172.656546868744, 38350.23299534049, 38576.22847542977, 40295.597044029186, 40403.1919361617, 40616.593834061285, 54611.45388546223, 57054.7147264261, 57719.422805771406, 57941.0, 57946.0, 9014.278857691237, 9159.725208243763, 9235.953820230856, 9245.399049061789, 9253.240279162512, 12778.936105319413, 13837.930810345884, 13987.860121398655, 14000.579982600539, 14042.719145617235, 11698.649040528799, 11842.230255033395, 12129.514819407124, 12308.630741077783, 12363.69090772738, 11675.649730508097, 11715.121365897763, 11774.811352320605, 11904.226225295328, 11910.404479775803, 12141.817872732092, 12465.688357791129, 12491.750164996467, 12506.687332816753, 12587.24476531411, 8931.955340223258, 8949.910500894908, 9011.459312441275, 9086.273098152264, 9250.259979201513, 11795.823062654239, 11969.281843089442, 12112.576059837864, 12123.211991220542, 12538.811917821058], "value": 9392.095000749785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.0, 1615.030981411153, 1616.12538422833, 1854.656888475632, 1956.4032969944171, 8199.262066414021, 8448.028476725187, 8449.281811046061, 8452.366072544568, 8462.153784621534, 8305.792355191123, 8483.490990540557, 8485.278751306147, 8490.872636910452, 8503.91496085039, 2402.903883844644, 2428.8178386620984, 2429.3805079704653, 2433.5862903306393, 2436.2082323244927, 2356.7171939367213, 2412.963805542918, 2443.6823212982285, 2445.461998360358, 2448.7796098351146, 2388.844725092872, 2402.7477114902945, 2410.650455683925, 2458.53287875304, 2459.348272707734, 2331.7668233176714, 2364.680768096302, 2382.4996750682376, 2395.3532546212514, 2398.400399900025, 2373.0507796881384, 2424.224248240546, 2438.1588352018525, 2438.7927026202615, 2440.9511809763885, 7319.194888562254, 7489.063867016623, 8685.0, 8707.608157632858, 8726.52004139772, 5107.668001579923, 5204.063268611649, 5206.843794686166, 5207.531322180984, 5208.244804503363, 3556.76881002734, 3557.288542291526, 3609.097725568608, 3646.453032045188, 3665.0287673766475, 1153.4578747988432, 1188.8632807227193, 1191.326900301327, 1212.7574485102925, 1263.1789336930976, 12008.279503229835, 12096.879031209752, 12155.027597792156, 12203.69490762738, 12209.389530523438, 4660.04469083837, 4727.57451829337, 4730.881727956828, 4760.190767569521, 4862.635302352267, 10401.427921464392, 10431.94784026075, 10451.947740261403, 10452.895471045344, 10456.163506919429, 5458.235846981426, 5504.339479262434, 5512.6692398456225, 5514.503694667419, 5516.613837031369, 4934.629902757308, 5029.27075574047, 5045.9747701261995, 5047.116754567936, 5047.545720885065, 4031.8588849390717, 4132.73137246078, 4161.854335098257, 4174.415581818548, 4180.28935081037, 1324.5628942448968, 1360.1974834847488, 1360.6666366740212, 1360.7958806179151, 1360.931953402326, 992.5880759484877, 1022.1158697726413, 1048.3343077145914, 1073.6349641122056, 1096.6381094238882, 5913.615614985012, 5963.4931030862, 5978.0, 6073.453389194905, 6150.354212807681, 489.60586727683847, 494.6092586856415, 496.1565338923844, 499.92001279795784, 504.20839282327125, 4125.876223713293, 4180.1848639515, 4200.7059505834295, 4208.263553878059, 4250.298700714409, 9834.655787047419, 10198.541065652063, 10287.43419111956, 10293.794124117625, 10296.382217067, 9947.452890091114, 10056.547455364525, 10087.04173103554, 10125.291229613857, 10126.291159618757, 7703.1526532081425, 7835.6473958671995, 7856.410769192334, 7908.841823163504, 7939.087004994384, 5625.296837895263, 5664.943350566442, 5720.08478643415, 5800.39095894925, 5827.009408400498, 9036.45781253127, 9054.185123338932, 9091.181793638605, 9270.119338662817, 9285.953570232106, 9319.114684105, 9495.097965693249, 9502.23982081418, 9502.572384242587, 9511.286653501153, 7908.0, 7993.6003199838615, 8105.554194519358, 8281.420300578902, 8446.944131983502, 8322.916770832457, 8352.457090289112, 8383.077861435358, 8408.873866892123, 8411.53736544496, 7374.225706300976, 7553.773386798405, 7571.962140189484, 7610.9238907612435, 7692.153863074946, 7395.482316237812, 7421.851562968603, 7466.029416175862, 7540.095188577406, 7628.771136865903, 7078.221395646372, 7091.1490621125795, 7139.892901606376, 7140.571565706075, 7155.463340249398, 5070.188769796815, 5110.821121260738, 5180.818671346485, 5200.843974680765, 5258.579313654975, 5219.947800522098, 5221.060209162387, 5268.604854635841, 5335.306410166653, 5344.946550534601], "value": 4589.152850109303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.89503149055287, 349.98600055997764, 354.25606226923446, 355.4508284700138, 356.99107522311937, 6102.755889764409, 6147.385261473851, 6193.783217587374, 6204.100405441209, 6205.503559715229, 6075.270967483897, 6083.48290395317, 6083.878322433548, 6084.330723620409, 6112.266528016644, 4464.866054018376, 4518.344839998198, 4647.721136731807, 4653.860384188463, 4657.347971284023, 4604.608608268301, 4622.838200662977, 4632.4672662643725, 4636.142313671965, 4640.86077417678, 4454.576815202567, 4600.930986035212, 4602.2406302960135, 4605.217113090765, 4609.262517997121, 4529.456465224194, 4564.338170965208, 4574.153781550423, 4664.603508701764, 4665.300204969281, 4115.54728979812, 4122.855700050513, 4125.793710314502, 4129.793510324502, 4130.958690413087, 5874.9118763218585, 5881.500072493843, 5890.469857712784, 5904.940950590482, 5907.6160049597065, 5400.486953739389, 5405.459454054602, 5406.243125962368, 5409.540189083933, 5414.702191379472, 6363.5545511813725, 6369.904451433232, 6378.043293505965, 6379.425851673325, 6383.680815959184, 4328.329108988112, 4428.136513379892, 4524.47968483622, 4530.275155975061, 4533.184026875161, 6545.738170473175, 6650.634215118166, 6654.26803051664, 6685.9665701671665, 6699.899501507482, 4522.186006518858, 4540.614047805973, 4545.954540454619, 4547.567981041796, 4548.931766023512, 4575.542445755398, 4592.10453961481, 4592.770361481913, 4596.218642830727, 4597.3333866589155, 5320.787168513216, 5329.973350133225, 5330.38700549434, 5336.786528538815, 5339.466053394707, 6212.751489940442, 6377.904331435032, 6390.5526613136635, 6454.806355809334, 6464.159659244362, 1566.3891082477842, 1577.1798664694295, 1577.7002369549748, 1578.4712121439447, 1581.2805173646193, 1004.5931397783909, 1047.0785708576404, 1052.5894900988621, 1065.868263473054, 1068.1828401273033, 6175.135481032659, 6276.811695649138, 6285.96857015712, 6297.244330680348, 6340.7463701451425, 6724.361185687352, 6726.630035348005, 6727.697253623599, 6727.730890764413, 6736.023276624862, 6303.432691057827, 6314.336994615591, 6317.715702793385, 6322.367763223733, 6332.366763323631, 3562.5546806649168, 3562.590302115238, 3593.4609808528407, 3603.6756691897854, 3603.963960360415, 6769.492288078413, 6973.198082220508, 6985.336393042653, 7014.789556313319, 7058.647067646597, 6768.153980752406, 6784.491163162783, 6825.726970921207, 6827.69275382609, 6828.556143850733, 6995.0, 7013.614251216232, 7026.508144429943, 7027.61348125858, 7028.683709233097, 6687.398134167948, 6704.430123439367, 6705.698243578953, 6708.83227919306, 6716.83207919806, 6470.352964703492, 6476.579022363531, 6584.308647591934, 6591.406773390226, 6598.307177746267, 6982.371586557234, 6998.580085194904, 7006.649667516502, 7009.088818453569, 7020.684069217, 4578.153041687298, 4581.816727331003, 4582.33556134352, 4585.12882552314, 4588.357629931879, 6680.5991640501725, 6681.799546013627, 6689.09697190873, 6697.229818570732, 6699.229588597179, 6323.399277068671, 6457.418832305115, 6467.353264673495, 6481.287058423475, 6486.189226346707, 6363.96818015907, 6451.967740161269, 6455.838604034937, 6463.15978922737, 6464.0627109069865, 6312.747490100344, 6335.081413195153, 6356.4279214870885, 6360.332165122595, 6363.522735794926, 6507.804765857032, 6513.5114866384265, 6515.087887695821, 6522.15212022434, 6523.543351965317, 6020.518358531394, 6195.845103872439, 6347.873042539216, 6359.523035772429, 6367.458766004941], "value": 4868.513551132606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.1670188162777, 865.7143142762889, 926.1340646495523, 936.5879013234172, 948.7675519497724, 14212.0, 14457.0602910811, 14487.348069336878, 14524.0, 16997.2351244194, 15089.547313580582, 15089.54731358061, 15093.169875656835, 15156.469523566677, 15171.620709482268, 724.6449239872451, 872.5724395046414, 887.4054383563013, 897.9551022448884, 909.9727008189765, 912.16536868765, 912.4160537256129, 915.450729562264, 915.7664795477144, 915.9679411220609, 975.5073687787657, 978.6525783346916, 979.5298256836722, 980.9901900981006, 982.9017098290185, 758.5789886612928, 939.5255396024997, 946.0444950599875, 947.209080417852, 948.1182500274776, 694.1531331775226, 694.7047504810436, 694.8540806430656, 695.4853408477741, 695.5965539986795, 15366.231688415535, 15743.291551880193, 15754.606134846606, 15768.290426930816, 15772.842271577252, 14586.416543338253, 14799.260036998216, 14825.55523334291, 14874.405023799036, 15263.0, 12159.574414895436, 12263.0, 12300.75398492034, 12352.197107188094, 12561.120721549496, 4522.276435770261, 4574.794134263932, 4577.450705915278, 4623.606993405565, 4648.767561621939, 54089.729551352386, 54377.0, 54621.453785462036, 54888.176677349875, 55162.72418637881, 10933.070688991525, 11066.225364224589, 11073.114150867912, 11084.556617735201, 11287.604933827277, 20083.59832803365, 20174.89912550428, 20196.596068078557, 20229.08969096394, 20294.594108117755, 8597.914020859836, 8715.564221789013, 8778.648854045767, 8833.249173820168, 8998.14517620825, 5021.824236151717, 5052.9242061369105, 5107.974460127675, 5120.283160357553, 5220.034293655686, 3624.05774498627, 3677.0439685681918, 3686.170611612366, 3694.8152592370275, 3697.7411581189594, 610.6702380714453, 642.1651852591613, 664.3821246241042, 752.0636807175102, 757.1822431773782, 794.4200733464488, 809.5304723260494, 815.0993152566447, 825.1665817524224, 847.9618417171242, 9547.331686781998, 9613.327067105376, 9737.610495580097, 9775.120239178508, 9785.168260697777, 708.674009955416, 726.9273072692688, 735.0627949364496, 790.3795520516367, 834.9624266908004, 4380.123975204971, 4551.2717965126085, 4588.0, 4665.790039448233, 4669.369635099286, 66999.33000669931, 67653.0, 67814.66092669604, 67948.32051679518, 68569.0, 58936.70531647314, 60829.69585152046, 61091.08363374553, 61287.0, 61422.0, 53434.73282633562, 54041.459585403645, 54639.45360546344, 55116.0, 55215.447845521834, 8955.910440895508, 9233.861492077758, 9239.72280831576, 9284.72145835626, 9285.0, 39404.21191576095, 40305.38015029014, 41347.379789302584, 41400.37899431571, 41985.58014419939, 45626.77186614046, 45824.770876145405, 49367.506324936294, 51550.0, 52694.73652631712, 11249.268797528135, 11486.655400338002, 11640.185187037165, 11668.124890633406, 11762.235454695418, 12856.485740570273, 12917.806232906702, 13226.338683066, 13269.535566255136, 13386.26375549354, 12797.0, 12805.295708736108, 13101.017423693453, 13201.735965280832, 13575.932120339336, 11961.342126182795, 12029.699257518632, 12147.392630368622, 12284.631461056182, 12375.504979800708, 11936.462859171184, 12009.399530023638, 12014.098942579516, 12158.574449894211, 12185.268883866996, 10092.949535252277, 10250.794984100425, 10273.537690804082, 10401.791964160826, 10498.212634052325, 9980.800383992135, 10145.594176232868, 10341.63804266847, 10343.94828025855, 10383.94808025955], "value": 7172.404717290188, "unit": "score"}], "name": "dromaeo_css", "value": 7471.363773906628, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 104.0, 110.0, 110.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 156.0, 194.0, 125.0, 151.0, 153.0, 130.0, 189.0, 126.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 161.0, 164.0, 161.0, 161.0, 160.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 172.0, 78.0, 75.0, 74.0, 76.0, 159.0, 73.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 147.0, 91.0, 91.0, 92.0, 143.0, 91.0, 90.0, 148.0], "value": 107.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 72.0, 51.0, 52.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 87.0, 71.0, 73.0, 73.0, 73.0, 73.0, 80.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 126.0, 113.0, 113.0, 109.0, 130.0, 115.0, 130.0, 129.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 158.0, 166.0, 171.0, 161.0, 163.0, 163.0, 159.0, 160.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1513.3999999999999, "alertThreshold": 2.0}]} 05:22:19 INFO - Return code: 0 05:22:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:22:19 ERROR - # TBPL SUCCESS # 05:22:19 INFO - Running post-action listener: _resource_record_post_action 05:22:19 INFO - Running post-run listener: _resource_record_post_run 05:22:20 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 28672; Write bytes: 462061568; Read time: 16; Write time: 423052 05:22:20 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242118656; Read time: 0; Write time: 299568 05:22:20 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219607040; Read time: 8; Write time: 123460 05:22:20 INFO - Running post-run listener: _upload_blobber_files 05:22:20 INFO - Blob upload gear active. 05:22:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:22:20 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:22:20 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:22:21 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:22 INFO - (blobuploader) - INFO - Done attempting. 05:22:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:22 INFO - (blobuploader) - INFO - Done attempting. 05:22:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:22 INFO - Return code: 0 05:22:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c412cbbf9849f7fdd14dd1358c51d39026c3992c5bdda22d5ca8a6ad1139d4a312f47cfe802849439485e1a05343d3525b0d77b3911162e10718312bac3b0c26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7488b218afb9b0fcff4783a0a9f0c47e1ea2d8a392788b7a40e3fee7937d8a3ec768bd6c89235c1ef87b5f82a2b0a7301d6cde1a69c29b811c051380d8ef7c76"} 05:22:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:22 INFO - Contents: 05:22:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c412cbbf9849f7fdd14dd1358c51d39026c3992c5bdda22d5ca8a6ad1139d4a312f47cfe802849439485e1a05343d3525b0d77b3911162e10718312bac3b0c26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7488b218afb9b0fcff4783a0a9f0c47e1ea2d8a392788b7a40e3fee7937d8a3ec768bd6c89235c1ef87b5f82a2b0a7301d6cde1a69c29b811c051380d8ef7c76"} 05:22:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:22 INFO - Copying logs to upload dir... 05:22:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.880850 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-08 05:22:22.901823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 05:22:22.905601) ========= 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-1467979318.444564-1463531910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c412cbbf9849f7fdd14dd1358c51d39026c3992c5bdda22d5ca8a6ad1139d4a312f47cfe802849439485e1a05343d3525b0d77b3911162e10718312bac3b0c26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7488b218afb9b0fcff4783a0a9f0c47e1ea2d8a392788b7a40e3fee7937d8a3ec768bd6c89235c1ef87b5f82a2b0a7301d6cde1a69c29b811c051380d8ef7c76"} build_url:https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/a-ngKbIWSfGJCteeTB2Xdg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c412cbbf9849f7fdd14dd1358c51d39026c3992c5bdda22d5ca8a6ad1139d4a312f47cfe802849439485e1a05343d3525b0d77b3911162e10718312bac3b0c26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7488b218afb9b0fcff4783a0a9f0c47e1ea2d8a392788b7a40e3fee7937d8a3ec768bd6c89235c1ef87b5f82a2b0a7301d6cde1a69c29b811c051380d8ef7c76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 05:22:22.931015) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:22:22.931360) ========= 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-1467979318.444564-1463531910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:22:23.016130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 05:22:23.016465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 05:22:23.016769) ========= ========= Total master_lag: 0.18 =========