builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1469781759.47 results: success (0) buildid: 20160729010726 builduid: 04e759694b4147f2854cd11e786d1b60 revision: 7971ab36aaca23ccf9a766465ad62e8eb365c321 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.468090) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.468731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.469118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.485962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.486416) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 01:42:39-- 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% 29.9M=0s 2016-07-29 01:42:40 (29.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.296453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.796956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.797286) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022377 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.847184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:39.847562) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7971ab36aaca23ccf9a766465ad62e8eb365c321 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7971ab36aaca23ccf9a766465ad62e8eb365c321 --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=a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 01:42:40,355 truncating revision to first 12 chars 2016-07-29 01:42:40,355 Setting DEBUG logging. 2016-07-29 01:42:40,355 attempt 1/10 2016-07-29 01:42:40,355 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7971ab36aaca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 01:42:40,850 unpacking tar archive at: fx-team-7971ab36aaca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.831615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:40.692977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:40.693365) ========= script_repo_revision: 7971ab36aaca23ccf9a766465ad62e8eb365c321 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:40.693784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:40.694045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 01:42:40.704560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-29 01:42:40.704920) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:42:41 INFO - MultiFileLogger online at 20160729 01:42:41 in /builds/slave/test 01:42:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:42:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:42:41 INFO - {'append_to_log': False, 01:42:41 INFO - 'base_work_dir': '/builds/slave/test', 01:42:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:42:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:42:41 INFO - 'branch': 'Fx-Team-Non-PGO', 01:42:41 INFO - 'buildbot_json_path': 'buildprops.json', 01:42:41 INFO - 'config_files': ('talos/linux_config.py',), 01:42:41 INFO - 'default_actions': ('clobber', 01:42:41 INFO - 'read-buildbot-config', 01:42:41 INFO - 'download-and-extract', 01:42:41 INFO - 'populate-webroot', 01:42:41 INFO - 'create-virtualenv', 01:42:41 INFO - 'install', 01:42:41 INFO - 'run-tests'), 01:42:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:42:41 INFO - 'download_minidump_stackwalk': True, 01:42:41 INFO - 'download_symbols': 'ondemand', 01:42:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:42:41 INFO - 'tooltool.py': '/tools/tooltool.py', 01:42:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:42:41 INFO - '/tools/misc-python/virtualenv.py')}, 01:42:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:42:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:42:41 INFO - 'installer_path': 'installer.exe', 01:42:41 INFO - 'log_level': 'info', 01:42:41 INFO - 'log_name': 'talos', 01:42:41 INFO - 'log_to_console': True, 01:42:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:42:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:42:41 INFO - 'opt_config_files': (), 01:42:41 INFO - 'pip_index': False, 01:42:41 INFO - 'sps_profile': False, 01:42:41 INFO - 'sps_profile_interval': 0, 01:42:41 INFO - 'suite': 'dromaeojs', 01:42:41 INFO - 'system_bits': '32', 01:42:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:42:41 INFO - 'title': 'talos-linux64-ix-064', 01:42:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:42:41 INFO - 'use_talos_json': True, 01:42:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:42:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:42:41 INFO - 'work_dir': 'build'} 01:42:41 INFO - [mozharness: 2016-07-29 08:42:41.307408Z] Running clobber step. 01:42:41 INFO - Running pre-action listener: _resource_record_pre_action 01:42:41 INFO - Running main action method: clobber 01:42:41 INFO - rmtree: /builds/slave/test/build 01:42:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:42:41 INFO - Running post-action listener: _resource_record_post_action 01:42:41 INFO - [mozharness: 2016-07-29 08:42:41.782172Z] Finished clobber step (success) 01:42:41 INFO - [mozharness: 2016-07-29 08:42:41.782273Z] Running read-buildbot-config step. 01:42:41 INFO - Running pre-action listener: _resource_record_pre_action 01:42:41 INFO - Running main action method: read_buildbot_config 01:42:41 INFO - Using buildbot properties: 01:42:41 INFO - { 01:42:41 INFO - "project": "", 01:42:41 INFO - "product": "firefox", 01:42:41 INFO - "script_repo_revision": "production", 01:42:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:42:41 INFO - "repository": "", 01:42:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:42:41 INFO - "buildid": "20160729010726", 01:42:41 INFO - "pgo_build": "False", 01:42:41 INFO - "basedir": "/builds/slave/test", 01:42:41 INFO - "buildnumber": 2038, 01:42:41 INFO - "slavename": "talos-linux64-ix-064", 01:42:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:42:41 INFO - "platform": "ubuntu64_hw", 01:42:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:42:41 INFO - "branch": "fx-team", 01:42:41 INFO - "repo_path": "integration/fx-team", 01:42:41 INFO - "revision": "7971ab36aaca23ccf9a766465ad62e8eb365c321", 01:42:41 INFO - "stage_platform": "linux64", 01:42:41 INFO - "builduid": "04e759694b4147f2854cd11e786d1b60", 01:42:41 INFO - "slavebuilddir": "test" 01:42:41 INFO - } 01:42:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:42:41 INFO - Running post-action listener: _resource_record_post_action 01:42:41 INFO - [mozharness: 2016-07-29 08:42:41.784707Z] Finished read-buildbot-config step (success) 01:42:41 INFO - [mozharness: 2016-07-29 08:42:41.784794Z] Running download-and-extract step. 01:42:41 INFO - Running pre-action listener: _resource_record_pre_action 01:42:41 INFO - Running main action method: download_and_extract 01:42:41 INFO - mkdir: /builds/slave/test/build/tests 01:42:41 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')]} 01:42:41 INFO - https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:42:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:42:42 INFO - Downloaded 1361 bytes. 01:42:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:42 INFO - Using the following test package requirements: 01:42:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:42:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:42:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:42:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:42 INFO - u'jsshell-linux-x86_64.zip'], 01:42:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:42:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:42:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:42:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:42:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:42:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:42:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:42 INFO - https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:42:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:42:43 INFO - Downloaded 22749814 bytes. 01:42:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:42:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:42:44 INFO - Return code: 0 01:42:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:42:44 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')]} 01:42:44 INFO - https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:42:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:42:45 INFO - Downloaded 22749814 bytes. 01:42:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:42:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:42:47 INFO - Return code: 0 01:42:47 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')]} 01:42:47 INFO - https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:42:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:42:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:42:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:42:48 INFO - Downloaded 14413725 bytes. 01:42:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:42:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:42:48 INFO - Return code: 0 01:42: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')]} 01:42:48 INFO - https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:42:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:42:49 INFO - Downloaded 57173434 bytes. 01:42:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:49 INFO - mkdir: /builds/slave/test/properties 01:42:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:42:49 INFO - Writing to file /builds/slave/test/properties/build_url 01:42:49 INFO - Contents: 01:42:49 INFO - build_url:https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:42:50 INFO - Running post-action listener: _resource_record_post_action 01:42:50 INFO - Running post-action listener: set_extra_try_arguments 01:42:50 INFO - [mozharness: 2016-07-29 08:42:50.284424Z] Finished download-and-extract step (success) 01:42:50 INFO - [mozharness: 2016-07-29 08:42:50.284656Z] Running populate-webroot step. 01:42:50 INFO - Running pre-action listener: _resource_record_pre_action 01:42:50 INFO - Running main action method: populate_webroot 01:42:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:42:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:42:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:42:50 INFO - '--tppagecycles', 01:42:50 INFO - '7'], 01:42:50 INFO - 'tests': ['tsvgm']}}, 01:42:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:42:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:42:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:42:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:42:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:50 INFO - 'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:42:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:42:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:50 INFO - 'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['damp', 'tps']}, 01:42:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:50 INFO - 'tests': ['damp', 'tps']}, 01:42:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['dromaeo_dom']}, 01:42:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:42:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['basic_compositor_video']}, 01:42:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:42:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['a11yr', 01:42:50 INFO - 'ts_paint', 01:42:50 INFO - 'tpaint', 01:42:50 INFO - 'sessionrestore', 01:42:50 INFO - 'sessionrestore_no_auto_restore', 01:42:50 INFO - 'tabpaint']}, 01:42:50 INFO - 'other-e10s': {'tests': ['a11yr', 01:42:50 INFO - 'ts_paint', 01:42:50 INFO - 'tpaint', 01:42:50 INFO - 'sessionrestore', 01:42:50 INFO - 'sessionrestore_no_auto_restore', 01:42:50 INFO - 'tabpaint']}, 01:42:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:42:50 INFO - 'ts_paint', 01:42:50 INFO - 'tpaint', 01:42:50 INFO - 'sessionrestore', 01:42:50 INFO - 'sessionrestore_no_auto_restore', 01:42:50 INFO - 'tabpaint']}, 01:42:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:42:50 INFO - 'ts_paint', 01:42:50 INFO - 'tpaint', 01:42:50 INFO - 'sessionrestore', 01:42:50 INFO - 'sessionrestore_no_auto_restore', 01:42:50 INFO - 'tabpaint']}, 01:42:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['a11yr', 01:42:50 INFO - 'ts_paint', 01:42:50 INFO - 'tpaint', 01:42:50 INFO - 'sessionrestore', 01:42:50 INFO - 'sessionrestore_no_auto_restore', 01:42:50 INFO - 'tabpaint']}, 01:42:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['a11yr', 01:42:50 INFO - 'ts_paint', 01:42:50 INFO - 'tpaint', 01:42:50 INFO - 'sessionrestore', 01:42:50 INFO - 'sessionrestore_no_auto_restore', 01:42:50 INFO - 'tabpaint']}, 01:42:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['tsvgx', 01:42:50 INFO - 'tsvgr_opacity', 01:42:50 INFO - 'tart', 01:42:50 INFO - 'tscrollx', 01:42:50 INFO - 'cart']}, 01:42:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:42:50 INFO - 'tsvgr_opacity', 01:42:50 INFO - 'tart', 01:42:50 INFO - 'tscrollx', 01:42:50 INFO - 'cart']}, 01:42:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:50 INFO - 'talos_options': ['--disable-e10s'], 01:42:50 INFO - 'tests': ['tp5o']}, 01:42:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:50 INFO - 'tests': ['tp5o']}, 01:42:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:50 INFO - 'talos_options': ['--disable-e10s', 01:42:50 INFO - '--xperf_path', 01:42:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:42:50 INFO - 'tests': ['tp5n']}, 01:42:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:50 INFO - 'talos_options': ['--xperf_path', 01:42:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:42:50 INFO - 'tests': ['tp5n']}}, 01:42:50 INFO - 'talos.zip': {'path': '', 01:42:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:42:50 INFO - Running post-action listener: _resource_record_post_action 01:42:50 INFO - [mozharness: 2016-07-29 08:42:50.303566Z] Finished populate-webroot step (success) 01:42:50 INFO - [mozharness: 2016-07-29 08:42:50.303655Z] Running create-virtualenv step. 01:42:50 INFO - Running pre-action listener: _resource_record_pre_action 01:42:50 INFO - Running main action method: create_virtualenv 01:42:50 INFO - Creating virtualenv /builds/slave/test/build/venv 01:42:50 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 01:42:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:42:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:42:50 INFO - Using real prefix '/usr' 01:42:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:42:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:42:52 INFO - Installing pip.................done. 01:42:52 INFO - Return code: 0 01:42:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:42:52 INFO - Using env: {'DISPLAY': ':0', 01:42:52 INFO - 'HOME': '/home/cltbld', 01:42:52 INFO - 'LANG': 'en_US.UTF-8', 01:42:52 INFO - 'LANGUAGE': 'en_US:en', 01:42:52 INFO - 'LOGNAME': 'cltbld', 01:42:52 INFO - 'MAIL': '/var/mail/cltbld', 01:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:52 INFO - 'MOZ_NO_REMOTE': '1', 01:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:52 INFO - 'NO_EM_RESTART': '1', 01:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:52 INFO - 'PWD': '/builds/slave/test', 01:42:52 INFO - 'SHELL': '/bin/bash', 01:42:52 INFO - 'SHLVL': '1', 01:42:52 INFO - 'TERM': 'linux', 01:42:52 INFO - 'TMOUT': '86400', 01:42:52 INFO - 'USER': 'cltbld', 01:42:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:52 INFO - '_': '/tools/buildbot/bin/python'} 01:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:53 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 01:42:53 INFO - Cleaning up... 01:42:53 INFO - Return code: 0 01:42:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:42:53 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')]} 01:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:53 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')]} 01:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:42:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:42:53 INFO - Using env: {'DISPLAY': ':0', 01:42:53 INFO - 'HOME': '/home/cltbld', 01:42:53 INFO - 'LANG': 'en_US.UTF-8', 01:42:53 INFO - 'LANGUAGE': 'en_US:en', 01:42:53 INFO - 'LOGNAME': 'cltbld', 01:42:53 INFO - 'MAIL': '/var/mail/cltbld', 01:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:53 INFO - 'MOZ_NO_REMOTE': '1', 01:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:53 INFO - 'NO_EM_RESTART': '1', 01:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:53 INFO - 'PWD': '/builds/slave/test', 01:42:53 INFO - 'SHELL': '/bin/bash', 01:42:53 INFO - 'SHLVL': '1', 01:42:53 INFO - 'TERM': 'linux', 01:42:53 INFO - 'TMOUT': '86400', 01:42:53 INFO - 'USER': 'cltbld', 01:42:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:53 INFO - '_': '/tools/buildbot/bin/python'} 01:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:53 INFO - Downloading/unpacking psutil>=3.1.1 01:42:53 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 01:42:53 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 01:42:53 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 01:42:53 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 01:42:53 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 01:42:53 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 01:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:42:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:42:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:42:55 INFO - Installing collected packages: psutil 01:42:55 INFO - Running setup.py install for psutil 01:42:55 INFO - building 'psutil._psutil_linux' extension 01:42:55 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 01:42:55 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 01:42:55 INFO - building 'psutil._psutil_posix' extension 01:42:55 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 01:42:55 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 01:42:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:42:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:42:55 INFO - Successfully installed psutil 01:42:55 INFO - Cleaning up... 01:42:55 INFO - Return code: 0 01:42:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:42:55 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')]} 01:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:55 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')]} 01:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:42:55 INFO - Using env: {'DISPLAY': ':0', 01:42:55 INFO - 'HOME': '/home/cltbld', 01:42:55 INFO - 'LANG': 'en_US.UTF-8', 01:42:55 INFO - 'LANGUAGE': 'en_US:en', 01:42:55 INFO - 'LOGNAME': 'cltbld', 01:42:55 INFO - 'MAIL': '/var/mail/cltbld', 01:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:55 INFO - 'MOZ_NO_REMOTE': '1', 01:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:55 INFO - 'NO_EM_RESTART': '1', 01:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:55 INFO - 'PWD': '/builds/slave/test', 01:42:55 INFO - 'SHELL': '/bin/bash', 01:42:55 INFO - 'SHLVL': '1', 01:42:55 INFO - 'TERM': 'linux', 01:42:55 INFO - 'TMOUT': '86400', 01:42:55 INFO - 'USER': 'cltbld', 01:42:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:55 INFO - '_': '/tools/buildbot/bin/python'} 01:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:42:58 INFO - Installing collected packages: mozsystemmonitor 01:42:58 INFO - Running setup.py install for mozsystemmonitor 01:42:58 INFO - Successfully installed mozsystemmonitor 01:42:58 INFO - Cleaning up... 01:42:58 INFO - Return code: 0 01:42:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:58 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:42:58 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==2.5.1'] in /builds/slave/test/build 01:42:58 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==2.5.1 01:42:58 INFO - Using env: {'DISPLAY': ':0', 01:42:58 INFO - 'HOME': '/home/cltbld', 01:42:58 INFO - 'LANG': 'en_US.UTF-8', 01:42:58 INFO - 'LANGUAGE': 'en_US:en', 01:42:58 INFO - 'LOGNAME': 'cltbld', 01:42:58 INFO - 'MAIL': '/var/mail/cltbld', 01:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:58 INFO - 'MOZ_NO_REMOTE': '1', 01:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:58 INFO - 'NO_EM_RESTART': '1', 01:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:58 INFO - 'PWD': '/builds/slave/test', 01:42:58 INFO - 'SHELL': '/bin/bash', 01:42:58 INFO - 'SHLVL': '1', 01:42:58 INFO - 'TERM': 'linux', 01:42:58 INFO - 'TMOUT': '86400', 01:42:58 INFO - 'USER': 'cltbld', 01:42:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:58 INFO - '_': '/tools/buildbot/bin/python'} 01:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:58 INFO - Downloading/unpacking jsonschema==2.5.1 01:42:58 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 01:42:58 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 01:42:58 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 01:42:58 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 01:42:58 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 01:42:58 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 01:43:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:43:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:43:00 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 01:43:00 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 01:43:00 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 01:43:00 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 01:43:00 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 01:43:00 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 01:43:00 INFO - Downloading functools32-3.2.3-2.tar.gz 01:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:43:00 INFO - warning: no files found matching '*.txt' 01:43:00 INFO - no previously-included directories found matching 'build' 01:43:00 INFO - no previously-included directories found matching 'dist' 01:43:00 INFO - no previously-included directories found matching '.git*' 01:43:00 INFO - Installing collected packages: jsonschema, functools32 01:43:00 INFO - Running setup.py install for functools32 01:43:00 INFO - warning: no files found matching '*.txt' 01:43:00 INFO - no previously-included directories found matching 'build' 01:43:00 INFO - no previously-included directories found matching 'dist' 01:43:00 INFO - no previously-included directories found matching '.git*' 01:43:00 INFO - Successfully installed jsonschema functools32 01:43:00 INFO - Cleaning up... 01:43:00 INFO - Return code: 0 01:43:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:00 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:43:00 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:43:00 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 functools32==3.2.3-2 01:43:00 INFO - Using env: {'DISPLAY': ':0', 01:43:00 INFO - 'HOME': '/home/cltbld', 01:43:00 INFO - 'LANG': 'en_US.UTF-8', 01:43:00 INFO - 'LANGUAGE': 'en_US:en', 01:43:00 INFO - 'LOGNAME': 'cltbld', 01:43:00 INFO - 'MAIL': '/var/mail/cltbld', 01:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:00 INFO - 'MOZ_NO_REMOTE': '1', 01:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:00 INFO - 'NO_EM_RESTART': '1', 01:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:00 INFO - 'PWD': '/builds/slave/test', 01:43:00 INFO - 'SHELL': '/bin/bash', 01:43:00 INFO - 'SHLVL': '1', 01:43:00 INFO - 'TERM': 'linux', 01:43:00 INFO - 'TMOUT': '86400', 01:43:00 INFO - 'USER': 'cltbld', 01:43:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:00 INFO - '_': '/tools/buildbot/bin/python'} 01:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:43:00 INFO - Cleaning up... 01:43:00 INFO - Return code: 0 01:43:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:00 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 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:43:00 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 01:43:00 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 01:43:00 INFO - Using env: {'DISPLAY': ':0', 01:43:00 INFO - 'HOME': '/home/cltbld', 01:43:00 INFO - 'LANG': 'en_US.UTF-8', 01:43:00 INFO - 'LANGUAGE': 'en_US:en', 01:43:00 INFO - 'LOGNAME': 'cltbld', 01:43:00 INFO - 'MAIL': '/var/mail/cltbld', 01:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:00 INFO - 'MOZ_NO_REMOTE': '1', 01:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:00 INFO - 'NO_EM_RESTART': '1', 01:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:00 INFO - 'PWD': '/builds/slave/test', 01:43:00 INFO - 'SHELL': '/bin/bash', 01:43:00 INFO - 'SHLVL': '1', 01:43:00 INFO - 'TERM': 'linux', 01:43:00 INFO - 'TMOUT': '86400', 01:43:00 INFO - 'USER': 'cltbld', 01:43:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:00 INFO - '_': '/tools/buildbot/bin/python'} 01:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:01 INFO - Downloading/unpacking blobuploader==1.2.4 01:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:03 INFO - Downloading blobuploader-1.2.4.tar.gz 01:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:43:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:43:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:03 INFO - Downloading docopt-0.6.1.tar.gz 01:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:43:03 INFO - Installing collected packages: blobuploader, requests, docopt 01:43:03 INFO - Running setup.py install for blobuploader 01:43:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:43:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:43:03 INFO - Running setup.py install for requests 01:43:04 INFO - Running setup.py install for docopt 01:43:04 INFO - Successfully installed blobuploader requests docopt 01:43:04 INFO - Cleaning up... 01:43:04 INFO - Return code: 0 01:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43: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')]} 01:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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')]} 01:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:04 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 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:43:04 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 01:43:04 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 01:43:04 INFO - Using env: {'DISPLAY': ':0', 01:43:04 INFO - 'HOME': '/home/cltbld', 01:43:04 INFO - 'LANG': 'en_US.UTF-8', 01:43:04 INFO - 'LANGUAGE': 'en_US:en', 01:43:04 INFO - 'LOGNAME': 'cltbld', 01:43:04 INFO - 'MAIL': '/var/mail/cltbld', 01:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:04 INFO - 'MOZ_NO_REMOTE': '1', 01:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:04 INFO - 'NO_EM_RESTART': '1', 01:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:04 INFO - 'PWD': '/builds/slave/test', 01:43:04 INFO - 'SHELL': '/bin/bash', 01:43:04 INFO - 'SHLVL': '1', 01:43:04 INFO - 'TERM': 'linux', 01:43:04 INFO - 'TMOUT': '86400', 01:43:04 INFO - 'USER': 'cltbld', 01:43:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:04 INFO - '_': '/tools/buildbot/bin/python'} 01:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:43:04 INFO - Running setup.py (path:/tmp/pip-_GXwIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:43:04 INFO - Running setup.py (path:/tmp/pip-GLCT6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:43:04 INFO - Running setup.py (path:/tmp/pip-tMTvEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:43:04 INFO - Running setup.py (path:/tmp/pip-vtHK0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:43:04 INFO - Running setup.py (path:/tmp/pip-OohUQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:43:04 INFO - Running setup.py (path:/tmp/pip-lpDAXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:43:05 INFO - Running setup.py (path:/tmp/pip-5NIUQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:43:05 INFO - Running setup.py (path:/tmp/pip-mVFMpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:43:05 INFO - Running setup.py (path:/tmp/pip-FaFY6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:43:05 INFO - Running setup.py (path:/tmp/pip-grC74R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:43:05 INFO - Running setup.py (path:/tmp/pip-RShOIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:43:05 INFO - Running setup.py (path:/tmp/pip-6lLBgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:43:05 INFO - Running setup.py (path:/tmp/pip-bpe7F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:43:05 INFO - Running setup.py (path:/tmp/pip-R8OvR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:05 INFO - Running setup.py (path:/tmp/pip-VYXqLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:43:05 INFO - Running setup.py (path:/tmp/pip-_SeUk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:43:05 INFO - Running setup.py (path:/tmp/pip-BB7hhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:43:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:43:05 INFO - Running setup.py install for manifestparser 01:43:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:43:05 INFO - Running setup.py install for mozcrash 01:43:06 INFO - Running setup.py install for mozdebug 01:43:06 INFO - Running setup.py install for mozdevice 01:43:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Running setup.py install for mozfile 01:43:06 INFO - Running setup.py install for mozhttpd 01:43:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Running setup.py install for mozinfo 01:43:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Running setup.py install for mozInstall 01:43:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Running setup.py install for mozleak 01:43:06 INFO - Running setup.py install for mozlog 01:43:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Running setup.py install for moznetwork 01:43:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:43:06 INFO - Running setup.py install for mozprocess 01:43:07 INFO - Running setup.py install for mozprofile 01:43:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:43:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:43:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:43:07 INFO - Running setup.py install for mozrunner 01:43:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:43:07 INFO - Running setup.py install for mozscreenshot 01:43:07 INFO - Running setup.py install for moztest 01:43:07 INFO - Running setup.py install for mozversion 01:43:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:43:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:43:07 INFO - Cleaning up... 01:43:07 INFO - Return code: 0 01:43:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43: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')]} 01:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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')]} 01:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:07 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 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:43:07 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 01:43:07 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 01:43:07 INFO - Using env: {'DISPLAY': ':0', 01:43:07 INFO - 'HOME': '/home/cltbld', 01:43:07 INFO - 'LANG': 'en_US.UTF-8', 01:43:07 INFO - 'LANGUAGE': 'en_US:en', 01:43:07 INFO - 'LOGNAME': 'cltbld', 01:43:07 INFO - 'MAIL': '/var/mail/cltbld', 01:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:07 INFO - 'MOZ_NO_REMOTE': '1', 01:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:07 INFO - 'NO_EM_RESTART': '1', 01:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:07 INFO - 'PWD': '/builds/slave/test', 01:43:07 INFO - 'SHELL': '/bin/bash', 01:43:07 INFO - 'SHLVL': '1', 01:43:07 INFO - 'TERM': 'linux', 01:43:07 INFO - 'TMOUT': '86400', 01:43:07 INFO - 'USER': 'cltbld', 01:43:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:07 INFO - '_': '/tools/buildbot/bin/python'} 01:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:43:07 INFO - Running setup.py (path:/tmp/pip-KmpiX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:43:07 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)) 01:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:43:07 INFO - Running setup.py (path:/tmp/pip-kgDCAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:43:07 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)) 01:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:43:07 INFO - Running setup.py (path:/tmp/pip-9yJUDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:43:08 INFO - Running setup.py (path:/tmp/pip-1HnR05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:43:08 INFO - Running setup.py (path:/tmp/pip-fw_BJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:43:08 INFO - Running setup.py (path:/tmp/pip-33L6RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:43:08 INFO - Running setup.py (path:/tmp/pip-SBp_AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:43:08 INFO - Running setup.py (path:/tmp/pip-ofTauI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:43:08 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:43:08 INFO - Running setup.py (path:/tmp/pip-zWCBvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:43:08 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:43:08 INFO - Running setup.py (path:/tmp/pip-GmFD7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:43:08 INFO - Running setup.py (path:/tmp/pip-VHWRjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:43:08 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:43:08 INFO - Running setup.py (path:/tmp/pip-E5tL5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:43:08 INFO - Running setup.py (path:/tmp/pip-3fqQQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:43:08 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:43:08 INFO - Running setup.py (path:/tmp/pip-cdPtBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:08 INFO - Running setup.py (path:/tmp/pip-SO7ZuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:08 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:43:08 INFO - Running setup.py (path:/tmp/pip-Tjpxto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:43:08 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)) 01:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:43:08 INFO - Running setup.py (path:/tmp/pip-sNx0BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:43:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:10 INFO - Downloading blessings-1.6.tar.gz 01:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:43:10 INFO - Installing collected packages: blessings 01:43:10 INFO - Running setup.py install for blessings 01:43:11 INFO - Successfully installed blessings 01:43:11 INFO - Cleaning up... 01:43:11 INFO - Return code: 0 01:43:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:43:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:43:11 INFO - Reading from file tmpfile_stdout 01:43:11 INFO - Current package versions: 01:43:11 INFO - argparse == 1.2.1 01:43:11 INFO - blessings == 1.6 01:43:11 INFO - blobuploader == 1.2.4 01:43:11 INFO - docopt == 0.6.1 01:43:11 INFO - functools32 == 3.2.3-2 01:43:11 INFO - jsonschema == 2.5.1 01:43:11 INFO - manifestparser == 1.1 01:43:11 INFO - mozInstall == 1.12 01:43:11 INFO - mozcrash == 0.17 01:43:11 INFO - mozdebug == 0.1 01:43:11 INFO - mozdevice == 0.48 01:43:11 INFO - mozfile == 1.2 01:43:11 INFO - mozhttpd == 0.7 01:43:11 INFO - mozinfo == 0.9 01:43:11 INFO - mozleak == 0.1 01:43:11 INFO - mozlog == 3.3 01:43:11 INFO - moznetwork == 0.27 01:43:11 INFO - mozprocess == 0.23 01:43:11 INFO - mozprofile == 0.28 01:43:11 INFO - mozrunner == 6.12 01:43:11 INFO - mozscreenshot == 0.1 01:43:11 INFO - mozsystemmonitor == 0.3 01:43:11 INFO - moztest == 0.7 01:43:11 INFO - mozversion == 1.4 01:43:11 INFO - psutil == 3.1.1 01:43:11 INFO - requests == 1.2.3 01:43:11 INFO - wsgiref == 0.1.2 01:43:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:11 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 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:43:11 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 01:43:11 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 01:43:11 INFO - Using env: {'DISPLAY': ':0', 01:43:11 INFO - 'HOME': '/home/cltbld', 01:43:11 INFO - 'LANG': 'en_US.UTF-8', 01:43:11 INFO - 'LANGUAGE': 'en_US:en', 01:43:11 INFO - 'LOGNAME': 'cltbld', 01:43:11 INFO - 'MAIL': '/var/mail/cltbld', 01:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:11 INFO - 'MOZ_NO_REMOTE': '1', 01:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:11 INFO - 'NO_EM_RESTART': '1', 01:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:11 INFO - 'PWD': '/builds/slave/test', 01:43:11 INFO - 'SHELL': '/bin/bash', 01:43:11 INFO - 'SHLVL': '1', 01:43:11 INFO - 'TERM': 'linux', 01:43:11 INFO - 'TMOUT': '86400', 01:43:11 INFO - 'USER': 'cltbld', 01:43:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:11 INFO - '_': '/tools/buildbot/bin/python'} 01:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 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)) 01:43:11 INFO - Cleaning up... 01:43:11 INFO - Return code: 0 01:43:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:11 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 0x21e9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24aa180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', '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 01:43:11 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 01:43:11 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 01:43:11 INFO - Using env: {'DISPLAY': ':0', 01:43:11 INFO - 'HOME': '/home/cltbld', 01:43:11 INFO - 'LANG': 'en_US.UTF-8', 01:43:11 INFO - 'LANGUAGE': 'en_US:en', 01:43:11 INFO - 'LOGNAME': 'cltbld', 01:43:11 INFO - 'MAIL': '/var/mail/cltbld', 01:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:11 INFO - 'MOZ_NO_REMOTE': '1', 01:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:11 INFO - 'NO_EM_RESTART': '1', 01:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:11 INFO - 'PWD': '/builds/slave/test', 01:43:11 INFO - 'SHELL': '/bin/bash', 01:43:11 INFO - 'SHLVL': '1', 01:43:11 INFO - 'TERM': 'linux', 01:43:11 INFO - 'TMOUT': '86400', 01:43:11 INFO - 'USER': 'cltbld', 01:43:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:11 INFO - '_': '/tools/buildbot/bin/python'} 01:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:43:11 INFO - Cleaning up... 01:43:11 INFO - Return code: 0 01:43:11 INFO - Running post-action listener: _resource_record_post_action 01:43:11 INFO - Running post-action listener: _start_resource_monitoring 01:43:11 INFO - Starting resource monitoring. 01:43:11 INFO - [mozharness: 2016-07-29 08:43:11.857414Z] Finished create-virtualenv step (success) 01:43:11 INFO - [mozharness: 2016-07-29 08:43:11.857893Z] Running install step. 01:43:11 INFO - Running pre-action listener: _resource_record_pre_action 01:43:11 INFO - Running main action method: install 01:43:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:43:12 INFO - Reading from file tmpfile_stdout 01:43:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:43:12 INFO - Reading from file tmpfile_stdout 01:43:12 INFO - Output received: 01:43:12 INFO - Usage: mozinstall [options] installer 01:43:12 INFO - Options: 01:43:12 INFO - -h, --help show this help message and exit 01:43:12 INFO - -d DEST, --destination=DEST 01:43:12 INFO - Directory to install application into. [default: 01:43:12 INFO - "/builds/slave/test"] 01:43:12 INFO - --app=APP Application being installed. [default: firefox] 01:43:12 INFO - mkdir: /builds/slave/test/build/application 01:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:43:28 INFO - Reading from file tmpfile_stdout 01:43:28 INFO - Output received: 01:43:28 INFO - /builds/slave/test/build/application/firefox/firefox 01:43:28 INFO - Running post-action listener: _resource_record_post_action 01:43:28 INFO - [mozharness: 2016-07-29 08:43:28.640578Z] Finished install step (success) 01:43:28 INFO - [mozharness: 2016-07-29 08:43:28.640861Z] Running run-tests step. 01:43:28 INFO - Running pre-action listener: _resource_record_pre_action 01:43:28 INFO - Running main action method: run_tests 01:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:43:28 INFO - Python 2.7.3 01:43:28 INFO - Return code: 0 01:43:28 INFO - grabbing minidump binary from tooltool 01:43: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')]} 01:43:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a83b0>, '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 0x24a92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:43:28 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 01:43:28 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 01:43:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:43:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:43:28 INFO - Return code: 0 01:43:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:43:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:43:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:43:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:43:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 01:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 01:43:28 INFO - Using env: {'DISPLAY': ':0', 01:43:28 INFO - 'HOME': '/home/cltbld', 01:43:28 INFO - 'LANG': 'en_US.UTF-8', 01:43:28 INFO - 'LANGUAGE': 'en_US:en', 01:43:28 INFO - 'LOGNAME': 'cltbld', 01:43:28 INFO - 'MAIL': '/var/mail/cltbld', 01:43:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:43:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:28 INFO - 'MOZ_NO_REMOTE': '1', 01:43:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:28 INFO - 'NO_EM_RESTART': '1', 01:43:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:28 INFO - 'PWD': '/builds/slave/test', 01:43:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:43:28 INFO - 'SHELL': '/bin/bash', 01:43:28 INFO - 'SHLVL': '1', 01:43:28 INFO - 'TERM': 'linux', 01:43:28 INFO - 'TMOUT': '86400', 01:43:28 INFO - 'USER': 'cltbld', 01:43:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286', 01:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:28 INFO - '_': '/tools/buildbot/bin/python'} 01:43:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 01:43:28 INFO - mozversion application_buildid: 20160729010726 01:43:28 INFO - mozversion application_changeset: 7971ab36aaca23ccf9a766465ad62e8eb365c321 01:43:28 INFO - mozversion application_display_name: Nightly 01:43:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:43:28 INFO - mozversion application_name: Firefox 01:43:28 INFO - mozversion application_remotingname: firefox 01:43:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:43:28 INFO - mozversion application_vendor: Mozilla 01:43:28 INFO - mozversion application_version: 50.0a1 01:43:28 INFO - mozversion platform_buildid: 20160729010726 01:43:28 INFO - mozversion platform_changeset: 7971ab36aaca23ccf9a766465ad62e8eb365c321 01:43:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:43:28 INFO - mozversion platform_version: 50.0a1 01:43:28 INFO - using testdate: 1469781808 01:43:28 INFO - actual date: 1469781808 01:43:28 INFO - starting webserver on 'localhost:40988' 01:43:28 INFO - SUITE-START | Running 2 tests 01:43:28 INFO - TEST-START | dromaeo_css 01:43:28 INFO - operating with platform_type : linux_ 01:43:28 INFO - Initialising browser for dromaeo_css test... 01:43:28 INFO - TEST-INFO | started process 5073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppgOxSC/profile http://localhost:40988/getInfo.html) 01:43:32 INFO - PROCESS | 5073 | JavaScript error: , line 0: uncaught exception: undefined 01:43:33 INFO - PROCESS | 5073 | __metrics Screen width/height:1600/1200 01:43:33 INFO - PROCESS | 5073 | colorDepth:24 01:43:33 INFO - PROCESS | 5073 | Browser inner width/height: 1024/697 01:43:33 INFO - PROCESS | 5073 | __metrics 01:43:34 INFO - PROCESS | 5073 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:43:34 INFO - PROCESS | 5073 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:43:35 INFO - PROCESS | 5073 | console.error: PushService: 01:43:35 INFO - PROCESS | 5073 | stateChangeProcessEnqueue: Error transitioning state 01:43:35 INFO - PROCESS | 5073 | UnknownError 01:43:35 INFO - TEST-INFO | 5073: exit 0 01:43:35 INFO - Browser initialized. 01:43:35 INFO - Running cycle 1/1 for dromaeo_css test... 01:43:35 INFO - TEST-INFO | started process 5152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppgOxSC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:43:47 INFO - PROCESS | 5152 | RSS: Main: 159551488 01:43:47 INFO - PROCESS | 5152 | 01:44:39 INFO - PROCESS | 5152 | 1469781879216 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] 01:46:51 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40988/tests/dromaeo/cssquery-ext.html) 01:46:52 INFO - PROCESS | 5152 | RSS: Main: 235384832 01:46:52 INFO - PROCESS | 5152 | 01:49:54 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-ext.html (next: http://localhost:40988/tests/dromaeo/cssquery-jquery.html) 01:49:55 INFO - PROCESS | 5152 | RSS: Main: 244645888 01:49:55 INFO - PROCESS | 5152 | 01:52:57 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40988/tests/dromaeo/cssquery-mootools.html) 01:52:58 INFO - PROCESS | 5152 | RSS: Main: 185708544 01:52:58 INFO - PROCESS | 5152 | 01:56:00 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40988/tests/dromaeo/cssquery-prototype.html) 01:56:01 INFO - PROCESS | 5152 | RSS: Main: 185856000 01:56:01 INFO - PROCESS | 5152 | 01:59:04 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40988/tests/dromaeo/cssquery-yui.html) 01:59:04 INFO - PROCESS | 5152 | RSS: Main: 185847808 01:59:04 INFO - PROCESS | 5152 | 02:02:07 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:40988/tests/dromaeo/cssquery-yui.html (next: http://localhost:40988/tests/dromaeo/cssquery-dojo.html) 02:02:08 INFO - PROCESS | 5152 | RSS: Main: 272670720 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - PROCESS | 5152 | __start_tp_report 02:02:08 INFO - PROCESS | 5152 | _x_x_mozilla_page_load 02:02:08 INFO - PROCESS | 5152 | _x_x_mozilla_page_load_details 02:02:08 INFO - PROCESS | 5152 | |i|pagename|runs| 02:02:08 INFO - PROCESS | 5152 | |0;dojo.html;2581.3804686875155;2584.483103379324;2616.045143522614;2620.4628051249497;2627.6189952456893;4527.049319642879;4602.976985115078;4693.413323334583;4705.552972467614;4729.054189162169;4644.233701439267;4648.930266046012;4664.253719404887;4716.198246298129;4792.1134590100855;4242.469691288589;4327.718698284617;4395.296752519597;4408.470983481987;4423.867283981485;4298.118885628454;4331.285337919239;4346.695731298794;4347.413099231595;4394.384786129945;4379.649628029766;4417.69076164667;4436.511983681792;4439.2453282941815;4440.511543730203;4203.6637069034405;4246.490421149451;4348.108637729258;4383.956160438387;4391.846285380028;4196.349565817303;4197.055662475949;4202.348635961431;4228.9788551057045;4230.302000169968;4599.862004139848;4652.255639097762;4655.4878963314;4720.362751028601;4724.078804633098;4858.052679727454;4974.179260422026;4982.750862456863;5022.522860328263;5024.271480635324;4990.65065445419;5046.041252162077;5076.64463487556;5105.591552675777;5128.640995130342;4721.480637129913;4755.334253204589;4757.928631070467;4760.904781904343;4776.21192503233;4947.233178857283;5034.043531728959;5223.268742376071;5242;5242.554382877422;4880.072786170616;4939.382577177853;4946.777395017233;4948.455669876311;4953.2074868020945;4962.702237865739;4984.202527595639;4988.002399520111;5029.974850125726;5031.5220054095535;4724.267738500538;4890.217565189552;4909.239067944474;4927.162382395001;4953.975230123826;4943.184374578226;4951.603871690256;4968.751562421864;4981.078500477423;5022.171341728574;4242.5121111072;4243.130158317537;4243.490781106287;4277.529471758104;4333.891652708645;3660.5790334111916;3660.762050466711;3765.8681946131755;3787.450819631138;3798.2593394287846;4267.97866010668;4296.505901821331;4302.784860757012;4308.073764140662;4364.476262848479;5044;5093.974530127326;5107.821226257063;5109.591232701375;5158.613104017214;4158.397032430281;4346.47842258931;4354.760488173181;4359.215341238608;4400.603945644907;4488.640908727294;4533.705309154894;4534.977325113353;4541.613962813198;4591.540845915381;4778.1638213312535;4795.136875362468;4805;4805.255185446262;4848.733319667311;4863.659543831898;5055.823046193513;5078.365204349457;5085.211792172071;5124.590032797441;4722.055588882168;4765.666403351732;4769.594584460359;4790.089882922233;4838.540338667962;4961.652684312064;4986.850394488171;4991;4992.450830408579;5044.596432285335;4845.709257444423;5045.2936588876855;5050.595952323732;5055.317532133262;5101.4133374660905;4770;4841.903161936812;4845.49122342149;4848.854534363974;4909.386326709161;4855.295982082649;4866.513348665105;4868.634852386014;4868.683535570177;4917.213245880642;4630;4784.330193772944;4810.807567697253;4851.611871050237;4859.489753575965;4869.95130048695;4923.483034281349;4936.9259461107395;4937.703737775745;5004.47453017428;4838.806447742051;4850.708957462563;4854.538818812207;4859.07677541266;4899.559039686445 02:02:08 INFO - PROCESS | 5152 | |1;ext.html;569.3722355862496;580.5819809736989;591.7632946821268;601.5127746525313;603.1465476350963;27422.314442138933;39357.2128557429;40318.798406008005;40470.79764601173;40545;40387;40765.7961710191;40872.591274087325;40874;40897.59102408975;7680.462367634282;7806.726764563241;7814.687412503493;7816.8827467588035;7819.921800781976;7402.925970740304;9749.756256093619;10037.19702423808;10045.14616257619;10326.896731032706;10151.796964060715;10232.74418139545;10235.692929212135;10239.283250172492;10251.077403033725;9998.900010999869;10063.496825158785;10064.94967525165;10065.597376104946;10067.748306292327;9963.800723985552;10007.89992100077;10013.549390277454;10020.69937901864;10022.047905448972;38558.61441385578;38812.41781373282;38875.611243887484;38882.416763748566;38942;3060.4644187267363;3106.0992312229428;3253.788503747249;3328.284418849935;3457.96261121665;29467.410651786846;29692.53966827436;30000;30650.54024189639;30946.53580196299;3209.759268054905;3244.23760416302;3244.4971029490466;3246;3296.571445712066;245770;248091.9999999982;248095;249185;249240.9999999982;53509.464905351226;54064;54325.45674543204;54355;54395.184072238946;32946.17634559155;33925.15187120292;34037.82981085079;35779.642203577634;35792.64207357945;13347.132436391603;13362.532311369056;13389.263590502616;13394.397252123677;13408.865911340958;10685.83971240432;10987.61543345979;10991.120710343153;11023.393713345682;11024.007839294502;16530.6693866122;16700.331986720394;16735.916320418564;17753.201105950262;18244.90877545604;6730;6756.527043106936;6838.829029274308;6917.481188910851;6948.27043160471;760.5094713909608;808.6037841457761;904.3127223310331;914.6432891172448;971.7133445633555;25981.740182597932;27784;27841.721582784317;28179.859100704776;28196.295092622848;919.7102912582515;980.367662857453;1011.9494025298706;1019.0828254570946;1023.902729240721;14060.929695351662;14513.274336283355;14818.555443336718;14934.10395376281;15077.246137693071;400696;403216;404950;405633;406026;49623.50376496261;50183.74908125436;50242.246366304535;50258;50281.24578131331;1181.1377694283221;1182.846229990113;1208.8791120888018;1211.4487908001838;1218.11686527267;25629.87185064137;26552.8672356637;27120.593191102544;27213.455730884874;27639.30901727473;42212.36681449842;43076.56923430851;43139.13721725611;43146;43178.13643727045;287103;287484;287830;287839;288816;22450.88774556117;23130;23163.189288374826;25511.23466296014;25894.741052589234;32671.83728384325;36406.453903190944;42253.57746422497;44692.55307446884;45183.774081129384;35307.470387943686;35610.64389356073;35979;36279.637203628685;36441;35146.297074058886;35631;35763.64236357603;36417.63582364142;36674;34995.65004349924;35039.29921401507;35070;35107;35122.297554049284;30967.225819354695;32359.838200809787;32926.67073329236;35314.470282945265;35747.82126089353;25116.874415627804;25212.49575008453;25258.36854078663;25682.357941051625;25760.61359079653 02:02:08 INFO - PROCESS | 5152 | |2;jquery.html;337.8310844577711;352.26728404917776;352.37805273691936;352.64735264735265;371.1593241308437;12787.104902656818;16007.439739609115;16167.676646467078;17316.56708582283;17432.825671743278;12269.754604907897;12374.566890158847;15077.246137693126;16671.91664041681;16833.56914662252;4400.691951563392;4855.271709243624;4958.801647934079;5074.010567939254;5074.974625126869;4970.403551573816;5003.149464591028;5027.120253955562;5046.621503387242;5063.46833582474;4770.642201834866;4952.479989601094;5009.949900501003;5010.298558201855;5012.974935125338;4905.215165573509;4934.1611925972675;4945.604351651895;4955.40535135786;4955.975220123894;4375.7155784873885;4383.802728877208;4384.342348647697;4385.276429389179;4589.954100458986;18691.15889784963;19978.30075947335;20053.598928021504;20167.092480838397;20179.394618161477;1779.9377021804305;1834.8256915592997;1954.2378472395776;2032.9936681342683;2446.4006318451916;8818.07410221924;8883.689070882552;8999.460032398012;9257.305702072372;9294.953525232331;1596.8882178247527;1633.8692904567606;1697.1090177656706;1726.18869131508;1734.046274548993;67130.66434667795;68340.6582967087;68595.65702171507;70720;71225.99999999948;9114.680986165453;9297.628094876129;9329.533523323807;9511.429314241168;9955.253355998184;13454.394552245172;13455.394507247198;13460.798088028687;13507.594772156852;13511.391987360592;6641.701123449457;6838.521303508806;6853.4174595158975;6939.097917270722;6945.131858517685;6366.681665916685;6454.709538070798;6463.095166676669;6646.700898459581;6687.732490700415;4155.10665206982;4204.621584057389;4206.26390381682;4308.095299987038;4321.2653848845775;1764.417742145089;1805.3681211575843;1833.62410705805;1843.0968825275518;1864.5991111910732;838.9513108614232;840.684743221292;852.5268475995882;885.2608072259607;908.8454962656365;16438.835611643968;16554.337826487048;16716.414925477795;17064.744028839577;17629.559261018578;814.2183503836266;814.7107776739291;840.2899549880341;877.925376343018;885.685581618529;9079.546022698838;9508.762280942894;9523.619055237852;9766.169875560516;9794.41117764471;181858;186152;377252;378261;380940;84076.57961710152;84396.3564893796;85486.57256713677;86810.56594716986;87072;911.0661571888735;926.5969303353063;933.8459154239611;935.6257497001254;942.688912658821;15285.235738212823;15453.227338633249;16046.759298610763;16066.839331606534;16112.516624500815;26699;27597.172084837486;39666.80166599149;40726.31647360473;40842.79578602088;52703.67555893317;54269.45730542644;55505.16742248789;56147.71926140343;57435.71282143563;7047.506674532733;7256.2743725627015;7359.77920662381;7460.92539074624;7641.732539361095;11401.704965162025;11534.769304614028;11837.112216583962;12139.696507587381;12256.75486490283;10030;10103.393796371947;10266.332688375232;10313.484325783831;10333.48332583383;10120.746981325527;10150.340227885164;10345.172386209235;10597.205209609465;10775.784484310114;10131.392116473035;10159.288849780445;10489.527971241465;10499.160067194758;10528.789424211625;6732.865342693217;7389.778306650809;7510.962445187739;7580.734674286374;7839.294463498312;9560.292144880234;10338.379697218192;10458.215633827645;10485.737856553647;10514.842277365693 02:02:08 INFO - PROCESS | 5152 | |3;mootools.html;1227.9631611051661;1352.2832898563759;1404.1224234853216;1468.6548661064649;1654.859336956358;6596.208454985403;7420.962895185523;7692;7693.384529237662;7917.524948503094;7583.469157159001;7637.579933103677;7645.503042302246;7647.694092236304;7651.808704782383;2163.3077415227135;2188.671699245118;2189.025883481851;2192.1560199323217;2192.429968208269;2125.6067627488965;2164.350694791556;2184.6832209329636;2185.3553201805507;2185.9234926777567;2153.3862849088014;2164.2641501889357;2174.3694328644674;2175.3365223606793;2206.7793220677963;2100.9684854727193;2101.7688054314012;2113.281484295347;2115.3230966090855;2115.333669893986;2050.3643870400224;2099.9475013124793;2101.2960658179527;2101.7162683037745;2106.178590349765;7444.925550744531;7602.885956710654;7647.082350117966;7664.425168112414;7673.040869891263;4543.840965566223;4725.173094708447;4734.786934587952;4741.431028276595;4742.644301677388;2768.2525718056213;2930.9853450732608;2964.733174014349;2981.105668299523;2986.5664481049002;909.7361765088183;918.9172974432333;935.9344845860793;937.5780898595659;942.8302905477011;10100.242481813893;10191.949040254825;10204.795904081877;10222.795544089076;10249.180065594735;3966.940495892564;4011.2378648056774;4123.3196522574035;4147.357159640261;4154.397612346193;8223.835523289501;8267.751967440987;8291;8302.045264794626;8313.043999939964;4545.499995000548;4554.180247555471;4557.521460246693;4559.110973360229;4562.749048802348;3606.3688854450365;4070.9592904070582;4239.300515414983;4252.978735106367;4256.34026725858;3314.585676790401;3330.234046169346;3416.43628801245;3416.6924976751716;3426.6573342665533;1009.0666133826328;1017.2014968250036;1018.7554986803113;1030.294248439821;1031.185363562777;809.8218391953761;829.5727700234385;842.5323945210467;849.392684230778;860.2257967829004;5042.4957504250015;5388.461153884658;5392.164214546751;5651.773929042874;5663.461971112738;809.1301850510607;835.1147783349669;856.6188046319328;872.8734333521604;880.506916126971;3667.6149004354693;3754.9061273468383;3780.2628487444686;3780.7920564369224;3880.5537363203593;9110.225630821322;9469;9480.431174129575;9575.760605984906;9611.423314601147;9547.474888881177;9569.760755981017;9581.473018983883;9584.616615335308;9586.520673966274;6868.519203655796;7139.32176443237;7194.46041546886;7237.457190710717;7393.371563417169;5428.294321738149;5636.971815140898;5651.886962260814;5744.368119506935;5887.0580707086665;8753.912460875565;8756.343274254585;8772.736817895218;8828.602712878064;8844.955775221082;8314.750557483285;8957.10428957099;9020.729378118667;9020.81958360816;9033.81932361336;5856.970715146397;6285.49716022708;6634.369734875179;6843.794686159423;6848.2124555674745;7447.292507211806;7528.698852045857;7535.058117735283;7536.773896783106;7537.849243014999;6377.585456945284;6424.550281480251;6490.740370385131;6490.902636460362;6582.76960306387;6490.1562796838;6526.24948130952;6625.569337993208;6670.299618540177;6684.097646817618;6038.63768173911;6118.326984031842;6120.143179954721;6146.877062458815;6148.200733904564;4232.32282834745;4243.575642435855;4291.871243862689;4305.504866940342;4399;4401.867943961686;4554.9316760249285;4562.1788078146255;4603.217453033059;4608.470025947059 02:02:08 INFO - PROCESS | 5152 | |4;prototype.html;286.8909814270577;291.7374363073234;295.6865722334325;298.6848874437468;301.24087300003976;4781.497942716017;4788.401449818773;4814.398200224972;4822.300766388871;4824.903501929959;4724.433068031833;4741.928871066937;4747.430308363001;4759.0012194878145;4771.5467030632035;3551.964480355189;3689.6310368963022;3698.1124530112847;3698.445233215012;3722.4416337549314;3616.439451884949;3730.5150330457004;3751.5873253942045;3770.095177157476;3799.544054713438;3695.3717867962378;3702.7222958278103;3704.1480459494333;3721.51620289362;3755.43668449732;3597.118705917041;3693.519842420495;3694.538182727159;3695.7782533048103;3705.3515634763808;3266.4936934775146;3272.3291725196514;3277.5575297334794;3285.2443937894177;3296.126526470487;4597.54024597541;4600.907981840344;4602.447706275235;4602.4477062752685;4614.3770590970125;4228.1966426378885;4262.2754131797665;4263.147370525876;4268.765217913014;4270.245691528947;4743;4914.262860570907;4924.359833221694;4939.728314942677;4971.304017437562;3577.5528058992627;3579.2125732338845;3584.354816133095;3598.8560457581925;3601.603823579404;5223.895522089537;5228.5555727763185;5229.999999999962;5235.769594145373;5238.423773384925;3589;3612.692921101736;3642.216923361437;3702.444633305026;3702.66675999156;3667.743257971916;3688.4467329900194;3701.0192299040777;3709.27669104522;3725.3666876631037;4227.3447615619625;4227.682923780667;4235.830566777295;4246.532881383046;4247.405363249148;4946.35697359341;4946.3817022872145;4948.505149485023;4981.576565991932;5017.84946451607;1240.1876770715196;1284.6382834195595;1287.311288460669;1290.3806173036994;1294.2850722792339;801.7755028592004;827.7335676415095;846.7502086884384;858.4463021351194;864.5763575847915;3955.734165067151;4169.644151054705;4188.32986722123;4326.437563116775;4372.475302963601;5099.847004589868;5120.4111527174855;5127.769250383667;5141.845744627667;5153.510416510426;4332.176886391576;4350.390945267665;4351.912021994502;4353.934690979638;4356.411884395629;2625.687156421789;2677.5046616376035;2685.2615530729204;2714.7963902707374;2715.3754636433337;4824.855254342376;4830.130576496264;4841.273808928619;4865.321464094882;4868.4197375391095;5218.869528261824;5222.843314700565;5239.423663397023;5249.9237656280375;5259.63182577216;4730.810767569259;4825.1555977703765;4845.9757701210565;4855.514448555116;4859.222524396079;5087.465816089258;5089.287499749964;5096.949030509648;5140.588752899685;5170.250313704567;5025.617955062387;5046.268291097844;5046.369203849519;5053.67151135175;5058.9494105058475;4660.86017419478;4907.47868160857;4921.778519966539;4936.617747030838;4939.629527785359;3597.298526787356;3606.765560238576;3628.818559071983;3640.8543658254434;3652.8173591319796;5209.723617713685;5236.633435659467;5237.2929654497675;5239.26650268955;5254.65844720092;4955.45489996093;5001.424836143745;5008.899822003613;5053.519915608012;5057.31726216956;4970.527799859007;4976.377952755905;4984.32711583946;4988.176950803222;5039;4930.827421040246;4982.701037937735;4999.200127979506;5003.249512573143;5012.122878496321;4812.927806082982;4869.805207791649;4988.6757360771435;5035.773390197523;5037.833731495492;4794.448638406628;4882.902341953212;4909.459959404391;4914.262860570943;4920.753962301942 02:02:08 INFO - PROCESS | 5152 | |5;yui.html;608.774753341264;628.472083449902;630.7823800788732;631.0120041338739;647.9935200647996;12183.390830458475;12918.289494077822;13073.346332683375;13257.602271931857;13273.203607783527;12971.351432428364;13194;13202.867971320284;13208.669783255424;13218.339083045857;642.5598465051455;773.2769860180734;788.1094363369384;788.4323287233183;789.1634867040926;760.7375455467883;785.0814546980018;788.5584072919155;790.6560646118928;790.8497385496765;820.3437250199846;822.2722890242148;823.7775800533852;823.9629216685264;825.145973916996;661.9503537234726;813.60540138033;814.2997022560563;814.3200427642926;814.5967745965785;586.3403670870271;599.1462166412845;602.6655206360468;602.8975074237391;603.2820943077767;12572.497100115985;12656;12674.239545627292;12677.049221308347;12685.746285074247;11663.650090497298;12481.438335274934;12516.123871329011;12657.240565566004;13102;11005.394703291317;11010.339379637167;11033.889661103367;11076.280041797258;11247.66257012291;4051.5948405159543;4102.159057393227;4128.153728485653;4154.729942553755;4214.494260688737;60619;61235.69382153105;61480;62566.687166564334;63594;9640.373375730554;9780.95109524462;9812.411255324703;9853.211743060538;10052.447115408577;17811.376601819135;17965.910170449064;17999.19003644839;18195.818041819413;18423;6601.73593056282;6665.900011499832;6823.522353435212;6846.281140480178;6944.201416837027;3628.564572251294;3728.6271372862498;3787.3750831113107;3816.5610954740005;3864.632859878307;2553.5914253719316;2632.0129951268273;2647.907323243677;2649.721779213155;2650.390410205625;465.9394278743742;476.73779421318136;482.5584590100019;526.2553486816113;551.7765305051461;491.57724357052905;527.9340082489689;541.9132938729784;559.8012705489574;571.331542095749;7900;7925.326347260548;8005.199480052064;8360.247577718035;8431.199036091684;426.2136358418712;516.1380494574071;521.3144714700157;526.1581469648609;531.319910514542;3644.635536446387;3674.412094064937;3689.151495156129;3820.8280627371837;3902.746321489094;63910;76042.23957760462;78555.21444785479;78784;86848;80204;81206.59396702978;81483.59258203671;82949.58525207336;83604.16395835964;66379.33620663828;69886;71870;72195;73990;7958;8049.436539442183;8560.22957933764;8586.16248365179;8616.138386161334;45240;45434.54565454435;46756.29865551952;46975;47018.76490617525;57803.1329530049;58679.119813201985;65559.34440655532;67479.32520674927;68342.31657683359;9458.479783611967;10205.285630005828;10288.176945844465;10339.741506462398;10688.412137332522;11671.183017188716;12175.573854915036;12351.19717218378;12363.443645035815;12906.904673360605;11350.886491134983;11374.772504550028;11400.828987565028;11474.196806223485;11632.18574699763;11224.607138750105;11739.354335511629;11973.940130299292;11978.46096925623;11989.160758746804;11084.778304433705;11374.260673056557;11947.641570752892;11967.820482692941;12024.458899349374;8910.732678019669;8914.687985920722;8921.420107692978;8991.730248092568;9415.2467802577;9497.905020949702;9742.75643108928;9842.261830362608;9849.950750246202;9863.210943124677 02:02:08 INFO - PROCESS | 5152 | __end_tp_report 02:02:08 INFO - PROCESS | 5152 | __start_cc_report 02:02:08 INFO - PROCESS | 5152 | _x_x_mozilla_cycle_collect,1120 02:02:08 INFO - PROCESS | 5152 | __end_cc_report 02:02:08 INFO - PROCESS | 5152 | __startTimestamp1469782928005__endTimestamp 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - PROCESS | 5152 | ------- Summary: start ------- 02:02:08 INFO - PROCESS | 5152 | Number of tests: 6 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - PROCESS | 5152 | [#0] dojo.html Cycles:165 Average:4642.74 Median:4790.09 stddev:487.94 (10.2%) stddev-sans-first:461.87 02:02:08 INFO - PROCESS | 5152 | Values: 2581.4 2584.5 2616.0 2620.5 2627.6 4527.0 4603.0 4693.4 4705.6 4729.1 4644.2 4648.9 4664.3 4716.2 4792.1 4242.5 4327.7 4395.3 4408.5 4423.9 4298.1 4331.3 4346.7 4347.4 4394.4 4379.6 4417.7 4436.5 4439.2 4440.5 4203.7 4246.5 4348.1 4384.0 4391.8 4196.3 4197.1 4202.3 4229.0 4230.3 4599.9 4652.3 4655.5 4720.4 4724.1 4858.1 4974.2 4982.8 5022.5 5024.3 4990.7 5046.0 5076.6 5105.6 5128.6 4721.5 4755.3 4757.9 4760.9 4776.2 4947.2 5034.0 5223.3 5242.0 5242.6 4880.1 4939.4 4946.8 4948.5 4953.2 4962.7 4984.2 4988.0 5030.0 5031.5 4724.3 4890.2 4909.2 4927.2 4954.0 4943.2 4951.6 4968.8 4981.1 5022.2 4242.5 4243.1 4243.5 4277.5 4333.9 3660.6 3660.8 3765.9 3787.5 3798.3 4268.0 4296.5 4302.8 4308.1 4364.5 5044.0 5094.0 5107.8 5109.6 5158.6 4158.4 4346.5 4354.8 4359.2 4400.6 4488.6 4533.7 4535.0 4541.6 4591.5 4778.2 4795.1 4805.0 4805.3 4848.7 4863.7 5055.8 5078.4 5085.2 5124.6 4722.1 4765.7 4769.6 4790.1 4838.5 4961.7 4986.9 4991.0 4992.5 5044.6 4845.7 5045.3 5050.6 5055.3 5101.4 4770.0 4841.9 4845.5 4848.9 4909.4 4855.3 4866.5 4868.6 4868.7 4917.2 4630.0 4784.3 4810.8 4851.6 4859.5 4870.0 4923.5 4936.9 4937.7 5004.5 4838.8 4850.7 4854.5 4859.1 4899.6 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - PROCESS | 5152 | [#1] ext.html Cycles:180 Average:46507.79 Median:32936.42 stddev:84304.66 (256.0%) stddev-sans-first:84470.60 02:02:08 INFO - PROCESS | 5152 | Values: 569.4 580.6 591.8 601.5 603.1 27422.3 39357.2 40318.8 40470.8 40545.0 40387.0 40765.8 40872.6 40874.0 40897.6 7680.5 7806.7 7814.7 7816.9 7819.9 7402.9 9749.8 10037.2 10045.1 10326.9 10151.8 10232.7 10235.7 10239.3 10251.1 9998.9 10063.5 10064.9 10065.6 10067.7 9963.8 10007.9 10013.5 10020.7 10022.0 38558.6 38812.4 38875.6 38882.4 38942.0 3060.5 3106.1 3253.8 3328.3 3458.0 29467.4 29692.5 30000.0 30650.5 30946.5 3209.8 3244.2 3244.5 3246.0 3296.6 245770.0 248092.0 248095.0 249185.0 249241.0 53509.5 54064.0 54325.5 54355.0 54395.2 32946.2 33925.2 34037.8 35779.6 35792.6 13347.1 13362.5 13389.3 13394.4 13408.9 10685.8 10987.6 10991.1 11023.4 11024.0 16530.7 16700.3 16735.9 17753.2 18244.9 6730.0 6756.5 6838.8 6917.5 6948.3 760.5 808.6 904.3 914.6 971.7 25981.7 27784.0 27841.7 28179.9 28196.3 919.7 980.4 1011.9 1019.1 1023.9 14060.9 14513.3 14818.6 14934.1 15077.2 400696.0 403216.0 404950.0 405633.0 406026.0 49623.5 50183.7 50242.2 50258.0 50281.2 1181.1 1182.8 1208.9 1211.4 1218.1 25629.9 26552.9 27120.6 27213.5 27639.3 42212.4 43076.6 43139.1 43146.0 43178.1 287103.0 287484.0 287830.0 287839.0 288816.0 22450.9 23130.0 23163.2 25511.2 25894.7 32671.8 36406.5 42253.6 44692.6 45183.8 35307.5 35610.6 35979.0 36279.6 36441.0 35146.3 35631.0 35763.6 36417.6 36674.0 34995.7 35039.3 35070.0 35107.0 35122.3 30967.2 32359.8 32926.7 35314.5 35747.8 25116.9 25212.5 25258.4 25682.4 25760.6 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - PROCESS | 5152 | [#2] jquery.html Cycles:180 Average:21908.92 Median:4384.07 stddev:53264.41 (1215.0%) stddev-sans-first:53389.21 02:02:08 INFO - PROCESS | 5152 | Values: 337.8 352.3 352.4 352.6 371.2 12787.1 16007.4 16167.7 17316.6 17432.8 12269.8 12374.6 15077.2 16671.9 16833.6 4400.7 4855.3 4958.8 5074.0 5075.0 4970.4 5003.1 5027.1 5046.6 5063.5 4770.6 4952.5 5009.9 5010.3 5013.0 4905.2 4934.2 4945.6 4955.4 4956.0 4375.7 4383.8 4384.3 4385.3 4590.0 18691.2 19978.3 20053.6 20167.1 20179.4 1779.9 1834.8 1954.2 2033.0 2446.4 8818.1 8883.7 8999.5 9257.3 9295.0 1596.9 1633.9 1697.1 1726.2 1734.0 67130.7 68340.7 68595.7 70720.0 71226.0 9114.7 9297.6 9329.5 9511.4 9955.3 13454.4 13455.4 13460.8 13507.6 13511.4 6641.7 6838.5 6853.4 6939.1 6945.1 6366.7 6454.7 6463.1 6646.7 6687.7 4155.1 4204.6 4206.3 4308.1 4321.3 1764.4 1805.4 1833.6 1843.1 1864.6 839.0 840.7 852.5 885.3 908.8 16438.8 16554.3 16716.4 17064.7 17629.6 814.2 814.7 840.3 877.9 885.7 9079.5 9508.8 9523.6 9766.2 9794.4 181858.0 186152.0 377252.0 378261.0 380940.0 84076.6 84396.4 85486.6 86810.6 87072.0 911.1 926.6 933.8 935.6 942.7 15285.2 15453.2 16046.8 16066.8 16112.5 26699.0 27597.2 39666.8 40726.3 40842.8 52703.7 54269.5 55505.2 56147.7 57435.7 7047.5 7256.3 7359.8 7460.9 7641.7 11401.7 11534.8 11837.1 12139.7 12256.8 10030.0 10103.4 10266.3 10313.5 10333.5 10120.7 10150.3 10345.2 10597.2 10775.8 10131.4 10159.3 10489.5 10499.2 10528.8 6732.9 7389.8 7511.0 7580.7 7839.3 9560.3 10338.4 10458.2 10485.7 10514.8 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - PROCESS | 5152 | [#3] mootools.html Cycles:180 Average:5040.40 Median:5651.83 stddev:2795.10 (49.5%) stddev-sans-first:2788.26 02:02:08 INFO - PROCESS | 5152 | Values: 1228.0 1352.3 1404.1 1468.7 1654.9 6596.2 7421.0 7692.0 7693.4 7917.5 7583.5 7637.6 7645.5 7647.7 7651.8 2163.3 2188.7 2189.0 2192.2 2192.4 2125.6 2164.4 2184.7 2185.4 2185.9 2153.4 2164.3 2174.4 2175.3 2206.8 2101.0 2101.8 2113.3 2115.3 2115.3 2050.4 2099.9 2101.3 2101.7 2106.2 7444.9 7602.9 7647.1 7664.4 7673.0 4543.8 4725.2 4734.8 4741.4 4742.6 2768.3 2931.0 2964.7 2981.1 2986.6 909.7 918.9 935.9 937.6 942.8 10100.2 10191.9 10204.8 10222.8 10249.2 3966.9 4011.2 4123.3 4147.4 4154.4 8223.8 8267.8 8291.0 8302.0 8313.0 4545.5 4554.2 4557.5 4559.1 4562.7 3606.4 4071.0 4239.3 4253.0 4256.3 3314.6 3330.2 3416.4 3416.7 3426.7 1009.1 1017.2 1018.8 1030.3 1031.2 809.8 829.6 842.5 849.4 860.2 5042.5 5388.5 5392.2 5651.8 5663.5 809.1 835.1 856.6 872.9 880.5 3667.6 3754.9 3780.3 3780.8 3880.6 9110.2 9469.0 9480.4 9575.8 9611.4 9547.5 9569.8 9581.5 9584.6 9586.5 6868.5 7139.3 7194.5 7237.5 7393.4 5428.3 5637.0 5651.9 5744.4 5887.1 8753.9 8756.3 8772.7 8828.6 8845.0 8314.8 8957.1 9020.7 9020.8 9033.8 5857.0 6285.5 6634.4 6843.8 6848.2 7447.3 7528.7 7535.1 7536.8 7537.8 6377.6 6424.6 6490.7 6490.9 6582.8 6490.2 6526.2 6625.6 6670.3 6684.1 6038.6 6118.3 6120.1 6146.9 6148.2 4232.3 4243.6 4291.9 4305.5 4399.0 4401.9 4554.9 4562.2 4603.2 4608.5 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - PROCESS | 5152 | [#4] prototype.html Cycles:180 Average:4143.77 Median:4753.22 stddev:1207.59 (25.4%) stddev-sans-first:1175.77 02:02:08 INFO - PROCESS | 5152 | Values: 286.9 291.7 295.7 298.7 301.2 4781.5 4788.4 4814.4 4822.3 4824.9 4724.4 4741.9 4747.4 4759.0 4771.5 3552.0 3689.6 3698.1 3698.4 3722.4 3616.4 3730.5 3751.6 3770.1 3799.5 3695.4 3702.7 3704.1 3721.5 3755.4 3597.1 3693.5 3694.5 3695.8 3705.4 3266.5 3272.3 3277.6 3285.2 3296.1 4597.5 4600.9 4602.4 4602.4 4614.4 4228.2 4262.3 4263.1 4268.8 4270.2 4743.0 4914.3 4924.4 4939.7 4971.3 3577.6 3579.2 3584.4 3598.9 3601.6 5223.9 5228.6 5230.0 5235.8 5238.4 3589.0 3612.7 3642.2 3702.4 3702.7 3667.7 3688.4 3701.0 3709.3 3725.4 4227.3 4227.7 4235.8 4246.5 4247.4 4946.4 4946.4 4948.5 4981.6 5017.8 1240.2 1284.6 1287.3 1290.4 1294.3 801.8 827.7 846.8 858.4 864.6 3955.7 4169.6 4188.3 4326.4 4372.5 5099.8 5120.4 5127.8 5141.8 5153.5 4332.2 4350.4 4351.9 4353.9 4356.4 2625.7 2677.5 2685.3 2714.8 2715.4 4824.9 4830.1 4841.3 4865.3 4868.4 5218.9 5222.8 5239.4 5249.9 5259.6 4730.8 4825.2 4846.0 4855.5 4859.2 5087.5 5089.3 5096.9 5140.6 5170.3 5025.6 5046.3 5046.4 5053.7 5058.9 4660.9 4907.5 4921.8 4936.6 4939.6 3597.3 3606.8 3628.8 3640.9 3652.8 5209.7 5236.6 5237.3 5239.3 5254.7 4955.5 5001.4 5008.9 5053.5 5057.3 4970.5 4976.4 4984.3 4988.2 5039.0 4930.8 4982.7 4999.2 5003.2 5012.1 4812.9 4869.8 4988.7 5035.8 5037.8 4794.4 4882.9 4909.5 4914.3 4920.8 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - PROCESS | 5152 | [#5] yui.html Cycles:180 Average:16977.38 Median:536.62 stddev:23418.58 (4364.1%) stddev-sans-first:23452.02 02:02:08 INFO - PROCESS | 5152 | Values: 608.8 628.5 630.8 631.0 648.0 12183.4 12918.3 13073.3 13257.6 13273.2 12971.4 13194.0 13202.9 13208.7 13218.3 642.6 773.3 788.1 788.4 789.2 760.7 785.1 788.6 790.7 790.8 820.3 822.3 823.8 824.0 825.1 662.0 813.6 814.3 814.3 814.6 586.3 599.1 602.7 602.9 603.3 12572.5 12656.0 12674.2 12677.0 12685.7 11663.7 12481.4 12516.1 12657.2 13102.0 11005.4 11010.3 11033.9 11076.3 11247.7 4051.6 4102.2 4128.2 4154.7 4214.5 60619.0 61235.7 61480.0 62566.7 63594.0 9640.4 9781.0 9812.4 9853.2 10052.4 17811.4 17965.9 17999.2 18195.8 18423.0 6601.7 6665.9 6823.5 6846.3 6944.2 3628.6 3728.6 3787.4 3816.6 3864.6 2553.6 2632.0 2647.9 2649.7 2650.4 465.9 476.7 482.6 526.3 551.8 491.6 527.9 541.9 559.8 571.3 7900.0 7925.3 8005.2 8360.2 8431.2 426.2 516.1 521.3 526.2 531.3 3644.6 3674.4 3689.2 3820.8 3902.7 63910.0 76042.2 78555.2 78784.0 86848.0 80204.0 81206.6 81483.6 82949.6 83604.2 66379.3 69886.0 71870.0 72195.0 73990.0 7958.0 8049.4 8560.2 8586.2 8616.1 45240.0 45434.5 46756.3 46975.0 47018.8 57803.1 58679.1 65559.3 67479.3 68342.3 9458.5 10205.3 10288.2 10339.7 10688.4 11671.2 12175.6 12351.2 12363.4 12906.9 11350.9 11374.8 11400.8 11474.2 11632.2 11224.6 11739.4 11973.9 11978.5 11989.2 11084.8 11374.3 11947.6 11967.8 12024.5 8910.7 8914.7 8921.4 8991.7 9415.2 9497.9 9742.8 9842.3 9850.0 9863.2 02:02:08 INFO - PROCESS | 5152 | -------- Summary: end -------- 02:02:08 INFO - PROCESS | 5152 | 02:02:08 INFO - TEST-INFO | 5152: exit 0 02:02:08 INFO - TEST-OK | dromaeo_css | took 1119956ms 02:02:08 INFO - TEST-START | kraken 02:02:08 INFO - operating with platform_type : linux_ 02:02:08 INFO - Initialising browser for kraken test... 02:02:08 INFO - TEST-INFO | started process 5343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSgIwno/profile http://localhost:40988/getInfo.html) 02:02:12 INFO - PROCESS | 5343 | JavaScript error: , line 0: uncaught exception: undefined 02:02:13 INFO - PROCESS | 5343 | __metrics Screen width/height:1600/1200 02:02:13 INFO - PROCESS | 5343 | colorDepth:24 02:02:13 INFO - PROCESS | 5343 | Browser inner width/height: 1024/697 02:02:13 INFO - PROCESS | 5343 | __metrics 02:02:14 INFO - PROCESS | 5343 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:02:14 INFO - PROCESS | 5343 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:02:14 INFO - PROCESS | 5343 | console.error: PushService: 02:02:14 INFO - PROCESS | 5343 | stateChangeProcessEnqueue: Error transitioning state 02:02:14 INFO - PROCESS | 5343 | UnknownError 02:02:15 INFO - TEST-INFO | 5343: exit 0 02:02:15 INFO - Browser initialized. 02:02:15 INFO - Running cycle 1/1 for kraken test... 02:02:15 INFO - TEST-INFO | started process 5426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSgIwno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:02:27 INFO - PROCESS | 5426 | RSS: Main: 159264768 02:02:27 INFO - PROCESS | 5426 | 02:02:30 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40988/tests/kraken/driver.html?testName=audio-beat-detection) 02:02:30 INFO - PROCESS | 5426 | RSS: Main: 215236608 02:02:30 INFO - PROCESS | 5426 | 02:02:33 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40988/tests/kraken/driver.html?testName=audio-dft) 02:02:34 INFO - PROCESS | 5426 | RSS: Main: 192581632 02:02:34 INFO - PROCESS | 5426 | 02:02:37 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40988/tests/kraken/driver.html?testName=audio-fft) 02:02:38 INFO - PROCESS | 5426 | RSS: Main: 273375232 02:02:38 INFO - PROCESS | 5426 | 02:02:40 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40988/tests/kraken/driver.html?testName=audio-oscillator) 02:02:40 INFO - PROCESS | 5426 | RSS: Main: 181600256 02:02:40 INFO - PROCESS | 5426 | 02:02:43 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:02:43 INFO - PROCESS | 5426 | RSS: Main: 186593280 02:02:43 INFO - PROCESS | 5426 | 02:02:47 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40988/tests/kraken/driver.html?testName=imaging-darkroom) 02:02:47 INFO - PROCESS | 5426 | RSS: Main: 222945280 02:02:47 INFO - PROCESS | 5426 | 02:02:51 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40988/tests/kraken/driver.html?testName=imaging-desaturate) 02:02:51 INFO - PROCESS | 5426 | RSS: Main: 216825856 02:02:51 INFO - PROCESS | 5426 | 02:02:54 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40988/tests/kraken/driver.html?testName=json-parse-financial) 02:02:55 INFO - PROCESS | 5426 | RSS: Main: 220372992 02:02:55 INFO - PROCESS | 5426 | 02:02:56 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:02:57 INFO - PROCESS | 5426 | RSS: Main: 186159104 02:02:57 INFO - PROCESS | 5426 | 02:02:59 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:03:00 INFO - PROCESS | 5426 | RSS: Main: 191574016 02:03:00 INFO - PROCESS | 5426 | 02:03:02 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:03:02 INFO - PROCESS | 5426 | RSS: Main: 195747840 02:03:02 INFO - PROCESS | 5426 | 02:03:05 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:03:06 INFO - PROCESS | 5426 | RSS: Main: 190693376 02:03:06 INFO - PROCESS | 5426 | 02:03:09 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:03:09 INFO - PROCESS | 5426 | RSS: Main: 194207744 02:03:09 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | Cycle 1(1): loaded http://localhost:40988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40988/tests/kraken/driver.html?testName=ai-astar) 02:03:11 INFO - PROCESS | 5426 | RSS: Main: 245366784 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | __start_tp_report 02:03:11 INFO - PROCESS | 5426 | _x_x_mozilla_page_load 02:03:11 INFO - PROCESS | 5426 | _x_x_mozilla_page_load_details 02:03:11 INFO - PROCESS | 5426 | |i|pagename|runs| 02:03:11 INFO - PROCESS | 5426 | |0;ai-astar;104;115;113;112;113;112;111;112;114;114 02:03:11 INFO - PROCESS | 5426 | |1;audio-beat-detection;156;126;128;179;127;123;144;133;154;123 02:03:11 INFO - PROCESS | 5426 | |2;audio-dft;162;161;161;162;162;162;161;161;161;162 02:03:11 INFO - PROCESS | 5426 | |3;audio-fft;76;76;76;120;77;77;77;75;109;75 02:03:11 INFO - PROCESS | 5426 | |4;audio-oscillator;85;86;122;85;85;85;127;84;85;132 02:03:11 INFO - PROCESS | 5426 | |5;imaging-gaussian-blur;118;117;116;117;117;117;119;117;117;117 02:03:11 INFO - PROCESS | 5426 | |6;imaging-darkroom;147;147;148;146;146;146;147;146;146;146 02:03:11 INFO - PROCESS | 5426 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;95;94 02:03:11 INFO - PROCESS | 5426 | |8;json-parse-financial;61;63;63;64;63;63;62;62;63;62 02:03:11 INFO - PROCESS | 5426 | |9;json-stringify-tinderbox;65;66;65;65;65;65;66;65;65;65 02:03:11 INFO - PROCESS | 5426 | |10;stanford-crypto-aes;79;78;79;79;88;79;78;77;77;83 02:03:11 INFO - PROCESS | 5426 | |11;stanford-crypto-ccm;140;152;140;128;140;141;125;127;171;135 02:03:11 INFO - PROCESS | 5426 | |12;stanford-crypto-pbkdf2;165;167;168;167;164;165;163;165;162;165 02:03:11 INFO - PROCESS | 5426 | |13;stanford-crypto-sha256-iterative;67;66;65;67;67;66;66;65;66;67 02:03:11 INFO - PROCESS | 5426 | __end_tp_report 02:03:11 INFO - PROCESS | 5426 | __start_cc_report 02:03:11 INFO - PROCESS | 5426 | _x_x_mozilla_cycle_collect,1966 02:03:11 INFO - PROCESS | 5426 | __end_cc_report 02:03:11 INFO - PROCESS | 5426 | __startTimestamp1469782991816__endTimestamp 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | ------- Summary: start ------- 02:03:11 INFO - PROCESS | 5426 | Number of tests: 14 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.06 (2.7%) stddev-sans-first:1.27 02:03:11 INFO - PROCESS | 5426 | Values: 104.0 115.0 113.0 112.0 113.0 112.0 111.0 112.0 114.0 114.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:138.50 stddev:18.62 (13.4%) stddev-sans-first:18.74 02:03:11 INFO - PROCESS | 5426 | Values: 156.0 126.0 128.0 179.0 127.0 123.0 144.0 133.0 154.0 123.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 02:03:11 INFO - PROCESS | 5426 | Values: 162.0 161.0 161.0 162.0 162.0 162.0 161.0 161.0 161.0 162.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:16.40 (21.6%) stddev-sans-first:17.15 02:03:11 INFO - PROCESS | 5426 | Values: 76.0 76.0 76.0 120.0 77.0 77.0 77.0 75.0 109.0 75.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:85.00 stddev:20.43 (24.0%) stddev-sans-first:21.15 02:03:11 INFO - PROCESS | 5426 | Values: 85.0 86.0 122.0 85.0 85.0 85.0 127.0 84.0 85.0 132.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 02:03:11 INFO - PROCESS | 5426 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:03:11 INFO - PROCESS | 5426 | Values: 147.0 147.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 02:03:11 INFO - PROCESS | 5426 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:0.84 (1.3%) stddev-sans-first:0.67 02:03:11 INFO - PROCESS | 5426 | Values: 61.0 63.0 63.0 64.0 63.0 63.0 62.0 62.0 63.0 62.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 02:03:11 INFO - PROCESS | 5426 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:3.37 (4.3%) stddev-sans-first:3.56 02:03:11 INFO - PROCESS | 5426 | Values: 79.0 78.0 79.0 79.0 88.0 79.0 78.0 77.0 77.0 83.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:140.00 stddev:13.62 (9.7%) stddev-sans-first:14.44 02:03:11 INFO - PROCESS | 5426 | Values: 140.0 152.0 140.0 128.0 140.0 141.0 125.0 127.0 171.0 135.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.00 stddev:1.85 (1.1%) stddev-sans-first:1.96 02:03:11 INFO - PROCESS | 5426 | Values: 165.0 167.0 168.0 167.0 164.0 165.0 163.0 165.0 162.0 165.0 02:03:11 INFO - PROCESS | 5426 | 02:03:11 INFO - PROCESS | 5426 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 02:03:11 INFO - PROCESS | 5426 | Values: 67.0 66.0 65.0 67.0 67.0 66.0 66.0 65.0 66.0 67.0 02:03:11 INFO - PROCESS | 5426 | -------- Summary: end -------- 02:03:11 INFO - PROCESS | 5426 | 02:03:12 INFO - TEST-INFO | 5426: exit 0 02:03:12 INFO - TEST-OK | kraken | took 64105ms 02:03:12 INFO - SUITE-END | took 1184s 02:03:12 INFO - Completed test suite (00:19:44) 02:03:12 INFO - javascript benchmark 02:03:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.3804686875155, 2584.483103379324, 2616.045143522614, 2620.4628051249497, 2627.6189952456893, 4527.049319642879, 4602.976985115078, 4693.413323334583, 4705.552972467614, 4729.054189162169, 4644.233701439267, 4648.930266046012, 4664.253719404887, 4716.198246298129, 4792.1134590100855, 4242.469691288589, 4327.718698284617, 4395.296752519597, 4408.470983481987, 4423.867283981485, 4298.118885628454, 4331.285337919239, 4346.695731298794, 4347.413099231595, 4394.384786129945, 4379.649628029766, 4417.69076164667, 4436.511983681792, 4439.2453282941815, 4440.511543730203, 4203.6637069034405, 4246.490421149451, 4348.108637729258, 4383.956160438387, 4391.846285380028, 4196.349565817303, 4197.055662475949, 4202.348635961431, 4228.9788551057045, 4230.302000169968, 4599.862004139848, 4652.255639097762, 4655.4878963314, 4720.362751028601, 4724.078804633098, 4858.052679727454, 4974.179260422026, 4982.750862456863, 5022.522860328263, 5024.271480635324, 4990.65065445419, 5046.041252162077, 5076.64463487556, 5105.591552675777, 5128.640995130342, 4721.480637129913, 4755.334253204589, 4757.928631070467, 4760.904781904343, 4776.21192503233, 4947.233178857283, 5034.043531728959, 5223.268742376071, 5242.0, 5242.554382877422, 4880.072786170616, 4939.382577177853, 4946.777395017233, 4948.455669876311, 4953.2074868020945, 4962.702237865739, 4984.202527595639, 4988.002399520111, 5029.974850125726, 5031.5220054095535, 4724.267738500538, 4890.217565189552, 4909.239067944474, 4927.162382395001, 4953.975230123826, 4943.184374578226, 4951.603871690256, 4968.751562421864, 4981.078500477423, 5022.171341728574, 4242.5121111072, 4243.130158317537, 4243.490781106287, 4277.529471758104, 4333.891652708645, 3660.5790334111916, 3660.762050466711, 3765.8681946131755, 3787.450819631138, 3798.2593394287846, 4267.97866010668, 4296.505901821331, 4302.784860757012, 4308.073764140662, 4364.476262848479, 5044.0, 5093.974530127326, 5107.821226257063, 5109.591232701375, 5158.613104017214, 4158.397032430281, 4346.47842258931, 4354.760488173181, 4359.215341238608, 4400.603945644907, 4488.640908727294, 4533.705309154894, 4534.977325113353, 4541.613962813198, 4591.540845915381, 4778.1638213312535, 4795.136875362468, 4805.0, 4805.255185446262, 4848.733319667311, 4863.659543831898, 5055.823046193513, 5078.365204349457, 5085.211792172071, 5124.590032797441, 4722.055588882168, 4765.666403351732, 4769.594584460359, 4790.089882922233, 4838.540338667962, 4961.652684312064, 4986.850394488171, 4991.0, 4992.450830408579, 5044.596432285335, 4845.709257444423, 5045.2936588876855, 5050.595952323732, 5055.317532133262, 5101.4133374660905, 4770.0, 4841.903161936812, 4845.49122342149, 4848.854534363974, 4909.386326709161, 4855.295982082649, 4866.513348665105, 4868.634852386014, 4868.683535570177, 4917.213245880642, 4630.0, 4784.330193772944, 4810.807567697253, 4851.611871050237, 4859.489753575965, 4869.95130048695, 4923.483034281349, 4936.9259461107395, 4937.703737775745, 5004.47453017428, 4838.806447742051, 4850.708957462563, 4854.538818812207, 4859.07677541266, 4899.559039686445], "value": 4611.444570288706, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3722355862496, 580.5819809736989, 591.7632946821268, 601.5127746525313, 603.1465476350963, 27422.314442138933, 39357.2128557429, 40318.798406008005, 40470.79764601173, 40545.0, 40387.0, 40765.7961710191, 40872.591274087325, 40874.0, 40897.59102408975, 7680.462367634282, 7806.726764563241, 7814.687412503493, 7816.8827467588035, 7819.921800781976, 7402.925970740304, 9749.756256093619, 10037.19702423808, 10045.14616257619, 10326.896731032706, 10151.796964060715, 10232.74418139545, 10235.692929212135, 10239.283250172492, 10251.077403033725, 9998.900010999869, 10063.496825158785, 10064.94967525165, 10065.597376104946, 10067.748306292327, 9963.800723985552, 10007.89992100077, 10013.549390277454, 10020.69937901864, 10022.047905448972, 38558.61441385578, 38812.41781373282, 38875.611243887484, 38882.416763748566, 38942.0, 3060.4644187267363, 3106.0992312229428, 3253.788503747249, 3328.284418849935, 3457.96261121665, 29467.410651786846, 29692.53966827436, 30000.0, 30650.54024189639, 30946.53580196299, 3209.759268054905, 3244.23760416302, 3244.4971029490466, 3246.0, 3296.571445712066, 245770.0, 248091.9999999982, 248095.0, 249185.0, 249240.9999999982, 53509.464905351226, 54064.0, 54325.45674543204, 54355.0, 54395.184072238946, 32946.17634559155, 33925.15187120292, 34037.82981085079, 35779.642203577634, 35792.64207357945, 13347.132436391603, 13362.532311369056, 13389.263590502616, 13394.397252123677, 13408.865911340958, 10685.83971240432, 10987.61543345979, 10991.120710343153, 11023.393713345682, 11024.007839294502, 16530.6693866122, 16700.331986720394, 16735.916320418564, 17753.201105950262, 18244.90877545604, 6730.0, 6756.527043106936, 6838.829029274308, 6917.481188910851, 6948.27043160471, 760.5094713909608, 808.6037841457761, 904.3127223310331, 914.6432891172448, 971.7133445633555, 25981.740182597932, 27784.0, 27841.721582784317, 28179.859100704776, 28196.295092622848, 919.7102912582515, 980.367662857453, 1011.9494025298706, 1019.0828254570946, 1023.902729240721, 14060.929695351662, 14513.274336283355, 14818.555443336718, 14934.10395376281, 15077.246137693071, 400696.0, 403216.0, 404950.0, 405633.0, 406026.0, 49623.50376496261, 50183.74908125436, 50242.246366304535, 50258.0, 50281.24578131331, 1181.1377694283221, 1182.846229990113, 1208.8791120888018, 1211.4487908001838, 1218.11686527267, 25629.87185064137, 26552.8672356637, 27120.593191102544, 27213.455730884874, 27639.30901727473, 42212.36681449842, 43076.56923430851, 43139.13721725611, 43146.0, 43178.13643727045, 287103.0, 287484.0, 287830.0, 287839.0, 288816.0, 22450.88774556117, 23130.0, 23163.189288374826, 25511.23466296014, 25894.741052589234, 32671.83728384325, 36406.453903190944, 42253.57746422497, 44692.55307446884, 45183.774081129384, 35307.470387943686, 35610.64389356073, 35979.0, 36279.637203628685, 36441.0, 35146.297074058886, 35631.0, 35763.64236357603, 36417.63582364142, 36674.0, 34995.65004349924, 35039.29921401507, 35070.0, 35107.0, 35122.297554049284, 30967.225819354695, 32359.838200809787, 32926.67073329236, 35314.470282945265, 35747.82126089353, 25116.874415627804, 25212.49575008453, 25258.36854078663, 25682.357941051625, 25760.61359079653], "value": 17616.941744589058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.8310844577711, 352.26728404917776, 352.37805273691936, 352.64735264735265, 371.1593241308437, 12787.104902656818, 16007.439739609115, 16167.676646467078, 17316.56708582283, 17432.825671743278, 12269.754604907897, 12374.566890158847, 15077.246137693126, 16671.91664041681, 16833.56914662252, 4400.691951563392, 4855.271709243624, 4958.801647934079, 5074.010567939254, 5074.974625126869, 4970.403551573816, 5003.149464591028, 5027.120253955562, 5046.621503387242, 5063.46833582474, 4770.642201834866, 4952.479989601094, 5009.949900501003, 5010.298558201855, 5012.974935125338, 4905.215165573509, 4934.1611925972675, 4945.604351651895, 4955.40535135786, 4955.975220123894, 4375.7155784873885, 4383.802728877208, 4384.342348647697, 4385.276429389179, 4589.954100458986, 18691.15889784963, 19978.30075947335, 20053.598928021504, 20167.092480838397, 20179.394618161477, 1779.9377021804305, 1834.8256915592997, 1954.2378472395776, 2032.9936681342683, 2446.4006318451916, 8818.07410221924, 8883.689070882552, 8999.460032398012, 9257.305702072372, 9294.953525232331, 1596.8882178247527, 1633.8692904567606, 1697.1090177656706, 1726.18869131508, 1734.046274548993, 67130.66434667795, 68340.6582967087, 68595.65702171507, 70720.0, 71225.99999999948, 9114.680986165453, 9297.628094876129, 9329.533523323807, 9511.429314241168, 9955.253355998184, 13454.394552245172, 13455.394507247198, 13460.798088028687, 13507.594772156852, 13511.391987360592, 6641.701123449457, 6838.521303508806, 6853.4174595158975, 6939.097917270722, 6945.131858517685, 6366.681665916685, 6454.709538070798, 6463.095166676669, 6646.700898459581, 6687.732490700415, 4155.10665206982, 4204.621584057389, 4206.26390381682, 4308.095299987038, 4321.2653848845775, 1764.417742145089, 1805.3681211575843, 1833.62410705805, 1843.0968825275518, 1864.5991111910732, 838.9513108614232, 840.684743221292, 852.5268475995882, 885.2608072259607, 908.8454962656365, 16438.835611643968, 16554.337826487048, 16716.414925477795, 17064.744028839577, 17629.559261018578, 814.2183503836266, 814.7107776739291, 840.2899549880341, 877.925376343018, 885.685581618529, 9079.546022698838, 9508.762280942894, 9523.619055237852, 9766.169875560516, 9794.41117764471, 181858.0, 186152.0, 377252.0, 378261.0, 380940.0, 84076.57961710152, 84396.3564893796, 85486.57256713677, 86810.56594716986, 87072.0, 911.0661571888735, 926.5969303353063, 933.8459154239611, 935.6257497001254, 942.688912658821, 15285.235738212823, 15453.227338633249, 16046.759298610763, 16066.839331606534, 16112.516624500815, 26699.0, 27597.172084837486, 39666.80166599149, 40726.31647360473, 40842.79578602088, 52703.67555893317, 54269.45730542644, 55505.16742248789, 56147.71926140343, 57435.71282143563, 7047.506674532733, 7256.2743725627015, 7359.77920662381, 7460.92539074624, 7641.732539361095, 11401.704965162025, 11534.769304614028, 11837.112216583962, 12139.696507587381, 12256.75486490283, 10030.0, 10103.393796371947, 10266.332688375232, 10313.484325783831, 10333.48332583383, 10120.746981325527, 10150.340227885164, 10345.172386209235, 10597.205209609465, 10775.784484310114, 10131.392116473035, 10159.288849780445, 10489.527971241465, 10499.160067194758, 10528.789424211625, 6732.865342693217, 7389.778306650809, 7510.962445187739, 7580.734674286374, 7839.294463498312, 9560.292144880234, 10338.379697218192, 10458.215633827645, 10485.737856553647, 10514.842277365693], "value": 7945.796776219754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.9631611051661, 1352.2832898563759, 1404.1224234853216, 1468.6548661064649, 1654.859336956358, 6596.208454985403, 7420.962895185523, 7692.0, 7693.384529237662, 7917.524948503094, 7583.469157159001, 7637.579933103677, 7645.503042302246, 7647.694092236304, 7651.808704782383, 2163.3077415227135, 2188.671699245118, 2189.025883481851, 2192.1560199323217, 2192.429968208269, 2125.6067627488965, 2164.350694791556, 2184.6832209329636, 2185.3553201805507, 2185.9234926777567, 2153.3862849088014, 2164.2641501889357, 2174.3694328644674, 2175.3365223606793, 2206.7793220677963, 2100.9684854727193, 2101.7688054314012, 2113.281484295347, 2115.3230966090855, 2115.333669893986, 2050.3643870400224, 2099.9475013124793, 2101.2960658179527, 2101.7162683037745, 2106.178590349765, 7444.925550744531, 7602.885956710654, 7647.082350117966, 7664.425168112414, 7673.040869891263, 4543.840965566223, 4725.173094708447, 4734.786934587952, 4741.431028276595, 4742.644301677388, 2768.2525718056213, 2930.9853450732608, 2964.733174014349, 2981.105668299523, 2986.5664481049002, 909.7361765088183, 918.9172974432333, 935.9344845860793, 937.5780898595659, 942.8302905477011, 10100.242481813893, 10191.949040254825, 10204.795904081877, 10222.795544089076, 10249.180065594735, 3966.940495892564, 4011.2378648056774, 4123.3196522574035, 4147.357159640261, 4154.397612346193, 8223.835523289501, 8267.751967440987, 8291.0, 8302.045264794626, 8313.043999939964, 4545.499995000548, 4554.180247555471, 4557.521460246693, 4559.110973360229, 4562.749048802348, 3606.3688854450365, 4070.9592904070582, 4239.300515414983, 4252.978735106367, 4256.34026725858, 3314.585676790401, 3330.234046169346, 3416.43628801245, 3416.6924976751716, 3426.6573342665533, 1009.0666133826328, 1017.2014968250036, 1018.7554986803113, 1030.294248439821, 1031.185363562777, 809.8218391953761, 829.5727700234385, 842.5323945210467, 849.392684230778, 860.2257967829004, 5042.4957504250015, 5388.461153884658, 5392.164214546751, 5651.773929042874, 5663.461971112738, 809.1301850510607, 835.1147783349669, 856.6188046319328, 872.8734333521604, 880.506916126971, 3667.6149004354693, 3754.9061273468383, 3780.2628487444686, 3780.7920564369224, 3880.5537363203593, 9110.225630821322, 9469.0, 9480.431174129575, 9575.760605984906, 9611.423314601147, 9547.474888881177, 9569.760755981017, 9581.473018983883, 9584.616615335308, 9586.520673966274, 6868.519203655796, 7139.32176443237, 7194.46041546886, 7237.457190710717, 7393.371563417169, 5428.294321738149, 5636.971815140898, 5651.886962260814, 5744.368119506935, 5887.0580707086665, 8753.912460875565, 8756.343274254585, 8772.736817895218, 8828.602712878064, 8844.955775221082, 8314.750557483285, 8957.10428957099, 9020.729378118667, 9020.81958360816, 9033.81932361336, 5856.970715146397, 6285.49716022708, 6634.369734875179, 6843.794686159423, 6848.2124555674745, 7447.292507211806, 7528.698852045857, 7535.058117735283, 7536.773896783106, 7537.849243014999, 6377.585456945284, 6424.550281480251, 6490.740370385131, 6490.902636460362, 6582.76960306387, 6490.1562796838, 6526.24948130952, 6625.569337993208, 6670.299618540177, 6684.097646817618, 6038.63768173911, 6118.326984031842, 6120.143179954721, 6146.877062458815, 6148.200733904564, 4232.32282834745, 4243.575642435855, 4291.871243862689, 4305.504866940342, 4399.0, 4401.867943961686, 4554.9316760249285, 4562.1788078146255, 4603.217453033059, 4608.470025947059], "value": 4062.8955719234114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.8909814270577, 291.7374363073234, 295.6865722334325, 298.6848874437468, 301.24087300003976, 4781.497942716017, 4788.401449818773, 4814.398200224972, 4822.300766388871, 4824.903501929959, 4724.433068031833, 4741.928871066937, 4747.430308363001, 4759.0012194878145, 4771.5467030632035, 3551.964480355189, 3689.6310368963022, 3698.1124530112847, 3698.445233215012, 3722.4416337549314, 3616.439451884949, 3730.5150330457004, 3751.5873253942045, 3770.095177157476, 3799.544054713438, 3695.3717867962378, 3702.7222958278103, 3704.1480459494333, 3721.51620289362, 3755.43668449732, 3597.118705917041, 3693.519842420495, 3694.538182727159, 3695.7782533048103, 3705.3515634763808, 3266.4936934775146, 3272.3291725196514, 3277.5575297334794, 3285.2443937894177, 3296.126526470487, 4597.54024597541, 4600.907981840344, 4602.447706275235, 4602.4477062752685, 4614.3770590970125, 4228.1966426378885, 4262.2754131797665, 4263.147370525876, 4268.765217913014, 4270.245691528947, 4743.0, 4914.262860570907, 4924.359833221694, 4939.728314942677, 4971.304017437562, 3577.5528058992627, 3579.2125732338845, 3584.354816133095, 3598.8560457581925, 3601.603823579404, 5223.895522089537, 5228.5555727763185, 5229.999999999962, 5235.769594145373, 5238.423773384925, 3589.0, 3612.692921101736, 3642.216923361437, 3702.444633305026, 3702.66675999156, 3667.743257971916, 3688.4467329900194, 3701.0192299040777, 3709.27669104522, 3725.3666876631037, 4227.3447615619625, 4227.682923780667, 4235.830566777295, 4246.532881383046, 4247.405363249148, 4946.35697359341, 4946.3817022872145, 4948.505149485023, 4981.576565991932, 5017.84946451607, 1240.1876770715196, 1284.6382834195595, 1287.311288460669, 1290.3806173036994, 1294.2850722792339, 801.7755028592004, 827.7335676415095, 846.7502086884384, 858.4463021351194, 864.5763575847915, 3955.734165067151, 4169.644151054705, 4188.32986722123, 4326.437563116775, 4372.475302963601, 5099.847004589868, 5120.4111527174855, 5127.769250383667, 5141.845744627667, 5153.510416510426, 4332.176886391576, 4350.390945267665, 4351.912021994502, 4353.934690979638, 4356.411884395629, 2625.687156421789, 2677.5046616376035, 2685.2615530729204, 2714.7963902707374, 2715.3754636433337, 4824.855254342376, 4830.130576496264, 4841.273808928619, 4865.321464094882, 4868.4197375391095, 5218.869528261824, 5222.843314700565, 5239.423663397023, 5249.9237656280375, 5259.63182577216, 4730.810767569259, 4825.1555977703765, 4845.9757701210565, 4855.514448555116, 4859.222524396079, 5087.465816089258, 5089.287499749964, 5096.949030509648, 5140.588752899685, 5170.250313704567, 5025.617955062387, 5046.268291097844, 5046.369203849519, 5053.67151135175, 5058.9494105058475, 4660.86017419478, 4907.47868160857, 4921.778519966539, 4936.617747030838, 4939.629527785359, 3597.298526787356, 3606.765560238576, 3628.818559071983, 3640.8543658254434, 3652.8173591319796, 5209.723617713685, 5236.633435659467, 5237.2929654497675, 5239.26650268955, 5254.65844720092, 4955.45489996093, 5001.424836143745, 5008.899822003613, 5053.519915608012, 5057.31726216956, 4970.527799859007, 4976.377952755905, 4984.32711583946, 4988.176950803222, 5039.0, 4930.827421040246, 4982.701037937735, 4999.200127979506, 5003.249512573143, 5012.122878496321, 4812.927806082982, 4869.805207791649, 4988.6757360771435, 5035.773390197523, 5037.833731495492, 4794.448638406628, 4882.902341953212, 4909.459959404391, 4914.262860570943, 4920.753962301942], "value": 3759.5288038822673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.774753341264, 628.472083449902, 630.7823800788732, 631.0120041338739, 647.9935200647996, 12183.390830458475, 12918.289494077822, 13073.346332683375, 13257.602271931857, 13273.203607783527, 12971.351432428364, 13194.0, 13202.867971320284, 13208.669783255424, 13218.339083045857, 642.5598465051455, 773.2769860180734, 788.1094363369384, 788.4323287233183, 789.1634867040926, 760.7375455467883, 785.0814546980018, 788.5584072919155, 790.6560646118928, 790.8497385496765, 820.3437250199846, 822.2722890242148, 823.7775800533852, 823.9629216685264, 825.145973916996, 661.9503537234726, 813.60540138033, 814.2997022560563, 814.3200427642926, 814.5967745965785, 586.3403670870271, 599.1462166412845, 602.6655206360468, 602.8975074237391, 603.2820943077767, 12572.497100115985, 12656.0, 12674.239545627292, 12677.049221308347, 12685.746285074247, 11663.650090497298, 12481.438335274934, 12516.123871329011, 12657.240565566004, 13102.0, 11005.394703291317, 11010.339379637167, 11033.889661103367, 11076.280041797258, 11247.66257012291, 4051.5948405159543, 4102.159057393227, 4128.153728485653, 4154.729942553755, 4214.494260688737, 60619.0, 61235.69382153105, 61480.0, 62566.687166564334, 63594.0, 9640.373375730554, 9780.95109524462, 9812.411255324703, 9853.211743060538, 10052.447115408577, 17811.376601819135, 17965.910170449064, 17999.19003644839, 18195.818041819413, 18423.0, 6601.73593056282, 6665.900011499832, 6823.522353435212, 6846.281140480178, 6944.201416837027, 3628.564572251294, 3728.6271372862498, 3787.3750831113107, 3816.5610954740005, 3864.632859878307, 2553.5914253719316, 2632.0129951268273, 2647.907323243677, 2649.721779213155, 2650.390410205625, 465.9394278743742, 476.73779421318136, 482.5584590100019, 526.2553486816113, 551.7765305051461, 491.57724357052905, 527.9340082489689, 541.9132938729784, 559.8012705489574, 571.331542095749, 7900.0, 7925.326347260548, 8005.199480052064, 8360.247577718035, 8431.199036091684, 426.2136358418712, 516.1380494574071, 521.3144714700157, 526.1581469648609, 531.319910514542, 3644.635536446387, 3674.412094064937, 3689.151495156129, 3820.8280627371837, 3902.746321489094, 63910.0, 76042.23957760462, 78555.21444785479, 78784.0, 86848.0, 80204.0, 81206.59396702978, 81483.59258203671, 82949.58525207336, 83604.16395835964, 66379.33620663828, 69886.0, 71870.0, 72195.0, 73990.0, 7958.0, 8049.436539442183, 8560.22957933764, 8586.16248365179, 8616.138386161334, 45240.0, 45434.54565454435, 46756.29865551952, 46975.0, 47018.76490617525, 57803.1329530049, 58679.119813201985, 65559.34440655532, 67479.32520674927, 68342.31657683359, 9458.479783611967, 10205.285630005828, 10288.176945844465, 10339.741506462398, 10688.412137332522, 11671.183017188716, 12175.573854915036, 12351.19717218378, 12363.443645035815, 12906.904673360605, 11350.886491134983, 11374.772504550028, 11400.828987565028, 11474.196806223485, 11632.18574699763, 11224.607138750105, 11739.354335511629, 11973.940130299292, 11978.46096925623, 11989.160758746804, 11084.778304433705, 11374.260673056557, 11947.641570752892, 11967.820482692941, 12024.458899349374, 8910.732678019669, 8914.687985920722, 8921.420107692978, 8991.730248092568, 9415.2467802577, 9497.905020949702, 9742.75643108928, 9842.261830362608, 9849.950750246202, 9863.210943124677], "value": 6398.190311516987, "unit": "score"}], "name": "dromaeo_css", "value": 6309.52977668346, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 112.0, 113.0, 112.0, 111.0, 112.0, 114.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 128.0, 179.0, 127.0, 123.0, 144.0, 133.0, 154.0, 123.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 120.0, 77.0, 77.0, 77.0, 75.0, 109.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 122.0, 85.0, 85.0, 85.0, 127.0, 84.0, 85.0, 132.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 63.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 88.0, 79.0, 78.0, 77.0, 77.0, 83.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 152.0, 140.0, 128.0, 140.0, 141.0, 125.0, 127.0, 171.0, 135.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 168.0, 167.0, 164.0, 165.0, 163.0, 165.0, 162.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 67.0, 67.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1531.7000000000003, "alertThreshold": 2.0}]} 02:03:13 INFO - Return code: 0 02:03:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:03:13 INFO - # TBPL SUCCESS # 02:03:13 INFO - Running post-action listener: _resource_record_post_action 02:03:13 INFO - [mozharness: 2016-07-29 09:03:13.119900Z] Finished run-tests step (success) 02:03:13 INFO - Running post-run listener: _resource_record_post_run 02:03:13 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551530496; Read time: 12; Write time: 504892 02:03:13 INFO - TinderboxPrint: CPU usage
13.0% 02:03:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:03:13 INFO - TinderboxPrint: I/O write bytes / time
551,530,496 / 504,892 02:03:13 INFO - TinderboxPrint: CPU idle
8,341.5 (87.0%) 02:03:13 INFO - TinderboxPrint: CPU user
1,197.8 (12.5%) 02:03:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:03:13 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251150336; Read time: 0; Write time: 319384 02:03:13 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300380160; Read time: 12; Write time: 185508 02:03:13 INFO - Running post-run listener: _upload_blobber_files 02:03:13 INFO - Blob upload gear active. 02:03:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:03:13 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 02:03:13 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:03:13 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:03:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:03:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:03:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:15 INFO - (blobuploader) - INFO - Done attempting. 02:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:03:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:19 INFO - (blobuploader) - INFO - Done attempting. 02:03:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:03:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:03:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:20 INFO - (blobuploader) - INFO - Done attempting. 02:03:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:03:20 INFO - Return code: 0 02:03:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:03:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:03:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0d79b621bd6f6a94da8d5cfbc4138c195ca2d202513ca959b0371e381c9def4c2cc42084f909b0f1a911fbf0310b559201d2b89cea40b6694bdcf00c0749491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed214d999fb9d047e96acdccabd14a0b7b2e0ffe9ada81dc96163a73cc68986888d10ea198170c20c7e94ec1147692169b429d5bfe985df200eca4f196471ceb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/331fdbb5da945ee545205e86fd6b6022f6eae7fba5cc0aed4dbbd6d65b98f9e7a1b7c7fd787e90daa57a55dde7af820f038fc743845cc9279959556a1b90e02a"} 02:03:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:03:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:03:20 INFO - Contents: 02:03:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0d79b621bd6f6a94da8d5cfbc4138c195ca2d202513ca959b0371e381c9def4c2cc42084f909b0f1a911fbf0310b559201d2b89cea40b6694bdcf00c0749491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed214d999fb9d047e96acdccabd14a0b7b2e0ffe9ada81dc96163a73cc68986888d10ea198170c20c7e94ec1147692169b429d5bfe985df200eca4f196471ceb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/331fdbb5da945ee545205e86fd6b6022f6eae7fba5cc0aed4dbbd6d65b98f9e7a1b7c7fd787e90daa57a55dde7af820f038fc743845cc9279959556a1b90e02a"} 02:03:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:03:20 INFO - Copying logs to upload dir... 02:03:20 INFO - mkdir: /builds/slave/test/build/upload/logs 02:03:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.098615 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-29 02:03:19.799943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 02:03:19.803769) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0d79b621bd6f6a94da8d5cfbc4138c195ca2d202513ca959b0371e381c9def4c2cc42084f909b0f1a911fbf0310b559201d2b89cea40b6694bdcf00c0749491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed214d999fb9d047e96acdccabd14a0b7b2e0ffe9ada81dc96163a73cc68986888d10ea198170c20c7e94ec1147692169b429d5bfe985df200eca4f196471ceb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/331fdbb5da945ee545205e86fd6b6022f6eae7fba5cc0aed4dbbd6d65b98f9e7a1b7c7fd787e90daa57a55dde7af820f038fc743845cc9279959556a1b90e02a"} build_url:https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/dLJj-6jIScyxuC3dIop1kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0d79b621bd6f6a94da8d5cfbc4138c195ca2d202513ca959b0371e381c9def4c2cc42084f909b0f1a911fbf0310b559201d2b89cea40b6694bdcf00c0749491", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed214d999fb9d047e96acdccabd14a0b7b2e0ffe9ada81dc96163a73cc68986888d10ea198170c20c7e94ec1147692169b429d5bfe985df200eca4f196471ceb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/331fdbb5da945ee545205e86fd6b6022f6eae7fba5cc0aed4dbbd6d65b98f9e7a1b7c7fd787e90daa57a55dde7af820f038fc743845cc9279959556a1b90e02a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 02:03:19.830392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 02:03:19.830791) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1469781759.204242-1720662286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 02:03:19.914278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 02:03:19.914601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 02:03:19.914932) ========= ========= Total master_lag: 0.15 =========