builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1469845980.31 results: success (0) buildid: 20160729183225 builduid: 5c01996c29e145c0a4b3929455181474 revision: 0cb2c7646aa072218accaf14615a2d4ba4408133 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.309095) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.309639) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.309993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.326859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.327627) ========= 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=db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 19:33:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-07-29 19:33:00 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.467586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.467912) ========= 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=db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014865 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.520517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:00.521261) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0cb2c7646aa072218accaf14615a2d4ba4408133 --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 0cb2c7646aa072218accaf14615a2d4ba4408133 --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=db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 19:33:00,666 truncating revision to first 12 chars 2016-07-29 19:33:00,666 Setting DEBUG logging. 2016-07-29 19:33:00,667 attempt 1/10 2016-07-29 19:33:00,667 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0cb2c7646aa0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 19:33:00,965 unpacking tar archive at: fx-team-0cb2c7646aa0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:01.191627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:01.191989) ========= script_repo_revision: 0cb2c7646aa072218accaf14615a2d4ba4408133 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:01.192509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:01.192845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 19:33:01.202893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-29 19:33:01.203218) ========= /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=db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:33:01 INFO - MultiFileLogger online at 20160729 19:33:01 in /builds/slave/test 19:33:01 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 19:33:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:33:01 INFO - {'append_to_log': False, 19:33:01 INFO - 'base_work_dir': '/builds/slave/test', 19:33:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:33:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:33:01 INFO - 'branch': 'Fx-Team-Non-PGO', 19:33:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:33:01 INFO - 'config_files': ('talos/linux_config.py',), 19:33:01 INFO - 'default_actions': ('clobber', 19:33:01 INFO - 'read-buildbot-config', 19:33:01 INFO - 'download-and-extract', 19:33:01 INFO - 'populate-webroot', 19:33:01 INFO - 'create-virtualenv', 19:33:01 INFO - 'install', 19:33:01 INFO - 'run-tests'), 19:33:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:33:01 INFO - 'download_minidump_stackwalk': True, 19:33:01 INFO - 'download_symbols': 'ondemand', 19:33:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:33:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:33:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:33:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:33:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:33:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:33:01 INFO - 'installer_path': 'installer.exe', 19:33:01 INFO - 'log_level': 'info', 19:33:01 INFO - 'log_name': 'talos', 19:33:01 INFO - 'log_to_console': True, 19:33:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:33:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:33:01 INFO - 'opt_config_files': (), 19:33:01 INFO - 'pip_index': False, 19:33:01 INFO - 'sps_profile': False, 19:33:01 INFO - 'sps_profile_interval': 0, 19:33:01 INFO - 'suite': 'dromaeojs', 19:33:01 INFO - 'system_bits': '32', 19:33:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:33:01 INFO - 'title': 'talos-linux64-ix-049', 19:33:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:33:01 INFO - 'use_talos_json': True, 19:33:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:33:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:33:01 INFO - 'work_dir': 'build'} 19:33:01 INFO - [mozharness: 2016-07-30 02:33:01.432526Z] Running clobber step. 19:33:01 INFO - Running pre-action listener: _resource_record_pre_action 19:33:01 INFO - Running main action method: clobber 19:33:01 INFO - rmtree: /builds/slave/test/build 19:33:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:33:01 INFO - Running post-action listener: _resource_record_post_action 19:33:01 INFO - [mozharness: 2016-07-30 02:33:01.891529Z] Finished clobber step (success) 19:33:01 INFO - [mozharness: 2016-07-30 02:33:01.891630Z] Running read-buildbot-config step. 19:33:01 INFO - Running pre-action listener: _resource_record_pre_action 19:33:01 INFO - Running main action method: read_buildbot_config 19:33:01 INFO - Using buildbot properties: 19:33:01 INFO - { 19:33:01 INFO - "project": "", 19:33:01 INFO - "product": "firefox", 19:33:01 INFO - "script_repo_revision": "production", 19:33:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:33:01 INFO - "repository": "", 19:33:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:33:01 INFO - "buildid": "20160729183225", 19:33:01 INFO - "pgo_build": "False", 19:33:01 INFO - "basedir": "/builds/slave/test", 19:33:01 INFO - "buildnumber": 2046, 19:33:01 INFO - "slavename": "talos-linux64-ix-049", 19:33:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:33:01 INFO - "platform": "ubuntu64_hw", 19:33:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:33:01 INFO - "branch": "fx-team", 19:33:01 INFO - "repo_path": "integration/fx-team", 19:33:01 INFO - "revision": "0cb2c7646aa072218accaf14615a2d4ba4408133", 19:33:01 INFO - "stage_platform": "linux64", 19:33:01 INFO - "builduid": "5c01996c29e145c0a4b3929455181474", 19:33:01 INFO - "slavebuilddir": "test" 19:33:01 INFO - } 19:33:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:33:01 INFO - Running post-action listener: _resource_record_post_action 19:33:01 INFO - [mozharness: 2016-07-30 02:33:01.894114Z] Finished read-buildbot-config step (success) 19:33:01 INFO - [mozharness: 2016-07-30 02:33:01.894204Z] Running download-and-extract step. 19:33:01 INFO - Running pre-action listener: _resource_record_pre_action 19:33:01 INFO - Running main action method: download_and_extract 19:33:01 INFO - mkdir: /builds/slave/test/build/tests 19:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:01 INFO - https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:33:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:33:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:33:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:03 INFO - Downloaded 1361 bytes. 19:33:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:33:03 INFO - Using the following test package requirements: 19:33:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:33:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:33:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:33:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:03 INFO - u'jsshell-linux-x86_64.zip'], 19:33:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:33:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:33:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:33:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:33:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:33:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:33:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:33:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:03 INFO - https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:16 INFO - Downloaded 22758364 bytes. 19:33:16 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'] 19:33:16 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 19:33:18 INFO - Return code: 0 19:33:18 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 19:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:18 INFO - https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:33:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:33:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:33:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:19 INFO - Downloaded 22758364 bytes. 19:33:19 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'] 19:33:19 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 19:33:21 INFO - Return code: 0 19:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:21 INFO - https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:33:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:33:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:33:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:22 INFO - Downloaded 14413725 bytes. 19:33:22 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'] 19:33:22 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 19:33:22 INFO - Return code: 0 19:33:22 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')]} 19:33:22 INFO - https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:33:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:33:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:33:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QY1sduHGSuSaDKm-5WAypQ/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 19:33:24 INFO - Downloaded 57171083 bytes. 19:33:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:33:24 INFO - mkdir: /builds/slave/test/properties 19:33:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:33:24 INFO - Writing to file /builds/slave/test/properties/build_url 19:33:24 INFO - Contents: 19:33:24 INFO - build_url:https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:33:25 INFO - Running post-action listener: _resource_record_post_action 19:33:25 INFO - Running post-action listener: set_extra_try_arguments 19:33:25 INFO - [mozharness: 2016-07-30 02:33:25.387937Z] Finished download-and-extract step (success) 19:33:25 INFO - [mozharness: 2016-07-30 02:33:25.388198Z] Running populate-webroot step. 19:33:25 INFO - Running pre-action listener: _resource_record_pre_action 19:33:25 INFO - Running main action method: populate_webroot 19:33:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:33:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:33:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:33:25 INFO - '--tppagecycles', 19:33:25 INFO - '7'], 19:33:25 INFO - 'tests': ['tsvgm']}}, 19:33:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:33:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:33:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:33:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:33:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:25 INFO - 'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:33:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:33:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:25 INFO - 'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['damp', 'tps']}, 19:33:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:25 INFO - 'tests': ['damp', 'tps']}, 19:33:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['dromaeo_dom']}, 19:33:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:33:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['basic_compositor_video']}, 19:33:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:33:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['a11yr', 19:33:25 INFO - 'ts_paint', 19:33:25 INFO - 'tpaint', 19:33:25 INFO - 'sessionrestore', 19:33:25 INFO - 'sessionrestore_no_auto_restore', 19:33:25 INFO - 'tabpaint']}, 19:33:25 INFO - 'other-e10s': {'tests': ['a11yr', 19:33:25 INFO - 'ts_paint', 19:33:25 INFO - 'tpaint', 19:33:25 INFO - 'sessionrestore', 19:33:25 INFO - 'sessionrestore_no_auto_restore', 19:33:25 INFO - 'tabpaint']}, 19:33:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:33:25 INFO - 'ts_paint', 19:33:25 INFO - 'tpaint', 19:33:25 INFO - 'sessionrestore', 19:33:25 INFO - 'sessionrestore_no_auto_restore', 19:33:25 INFO - 'tabpaint']}, 19:33:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:33:25 INFO - 'ts_paint', 19:33:25 INFO - 'tpaint', 19:33:25 INFO - 'sessionrestore', 19:33:25 INFO - 'sessionrestore_no_auto_restore', 19:33:25 INFO - 'tabpaint']}, 19:33:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['a11yr', 19:33:25 INFO - 'ts_paint', 19:33:25 INFO - 'tpaint', 19:33:25 INFO - 'sessionrestore', 19:33:25 INFO - 'sessionrestore_no_auto_restore', 19:33:25 INFO - 'tabpaint']}, 19:33:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['a11yr', 19:33:25 INFO - 'ts_paint', 19:33:25 INFO - 'tpaint', 19:33:25 INFO - 'sessionrestore', 19:33:25 INFO - 'sessionrestore_no_auto_restore', 19:33:25 INFO - 'tabpaint']}, 19:33:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['tsvgx', 19:33:25 INFO - 'tsvgr_opacity', 19:33:25 INFO - 'tart', 19:33:25 INFO - 'tscrollx', 19:33:25 INFO - 'cart']}, 19:33:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:33:25 INFO - 'tsvgr_opacity', 19:33:25 INFO - 'tart', 19:33:25 INFO - 'tscrollx', 19:33:25 INFO - 'cart']}, 19:33:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:25 INFO - 'talos_options': ['--disable-e10s'], 19:33:25 INFO - 'tests': ['tp5o']}, 19:33:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:25 INFO - 'tests': ['tp5o']}, 19:33:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:25 INFO - 'talos_options': ['--disable-e10s', 19:33:25 INFO - '--xperf_path', 19:33:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:33:25 INFO - 'tests': ['tp5n']}, 19:33:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:25 INFO - 'talos_options': ['--xperf_path', 19:33:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:33:25 INFO - 'tests': ['tp5n']}}, 19:33:25 INFO - 'talos.zip': {'path': '', 19:33:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:33:25 INFO - Running post-action listener: _resource_record_post_action 19:33:25 INFO - [mozharness: 2016-07-30 02:33:25.637598Z] Finished populate-webroot step (success) 19:33:25 INFO - [mozharness: 2016-07-30 02:33:25.637821Z] Running create-virtualenv step. 19:33:25 INFO - Running pre-action listener: _resource_record_pre_action 19:33:25 INFO - Running main action method: create_virtualenv 19:33:25 INFO - Creating virtualenv /builds/slave/test/build/venv 19:33:25 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 19:33:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:33:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:33:25 INFO - Using real prefix '/usr' 19:33:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:33:26 INFO - Installing distribute.............................................................................................................................................................................................done. 19:33:28 INFO - Installing pip.................done. 19:33:28 INFO - Return code: 0 19:33:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:33: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')]} 19:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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')]} 19:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:28 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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:28 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 19:33:28 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 19:33:28 INFO - Using env: {'DISPLAY': ':0', 19:33:28 INFO - 'HOME': '/home/cltbld', 19:33:28 INFO - 'LANG': 'en_US.UTF-8', 19:33:28 INFO - 'LANGUAGE': 'en_US:en', 19:33:28 INFO - 'LOGNAME': 'cltbld', 19:33:28 INFO - 'MAIL': '/var/mail/cltbld', 19:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:28 INFO - 'MOZ_NO_REMOTE': '1', 19:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:28 INFO - 'NO_EM_RESTART': '1', 19:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:28 INFO - 'PWD': '/builds/slave/test', 19:33:28 INFO - 'SHELL': '/bin/bash', 19:33:28 INFO - 'SHLVL': '1', 19:33:28 INFO - 'TERM': 'linux', 19:33:28 INFO - 'TMOUT': '86400', 19:33:28 INFO - 'USER': 'cltbld', 19:33:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:28 INFO - '_': '/tools/buildbot/bin/python'} 19:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:28 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 19:33:28 INFO - Cleaning up... 19:33:28 INFO - Return code: 0 19:33:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:33: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')]} 19:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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')]} 19:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:28 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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:28 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 19:33:28 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 19:33:28 INFO - Using env: {'DISPLAY': ':0', 19:33:28 INFO - 'HOME': '/home/cltbld', 19:33:28 INFO - 'LANG': 'en_US.UTF-8', 19:33:28 INFO - 'LANGUAGE': 'en_US:en', 19:33:28 INFO - 'LOGNAME': 'cltbld', 19:33:28 INFO - 'MAIL': '/var/mail/cltbld', 19:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:28 INFO - 'MOZ_NO_REMOTE': '1', 19:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:28 INFO - 'NO_EM_RESTART': '1', 19:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:28 INFO - 'PWD': '/builds/slave/test', 19:33:28 INFO - 'SHELL': '/bin/bash', 19:33:28 INFO - 'SHLVL': '1', 19:33:28 INFO - 'TERM': 'linux', 19:33:28 INFO - 'TMOUT': '86400', 19:33:28 INFO - 'USER': 'cltbld', 19:33:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:28 INFO - '_': '/tools/buildbot/bin/python'} 19:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:28 INFO - Downloading/unpacking psutil>=3.1.1 19:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:33:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:33:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:33:30 INFO - Installing collected packages: psutil 19:33:30 INFO - Running setup.py install for psutil 19:33:30 INFO - building 'psutil._psutil_linux' extension 19:33:30 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 19:33:30 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 19:33:30 INFO - building 'psutil._psutil_posix' extension 19:33:30 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 19:33:31 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 19:33:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:33:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:33:31 INFO - Successfully installed psutil 19:33:31 INFO - Cleaning up... 19:33:32 INFO - Return code: 0 19:33:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:33:32 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')]} 19:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:32 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')]} 19:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:32 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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:32 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 19:33:32 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 19:33:32 INFO - Using env: {'DISPLAY': ':0', 19:33:32 INFO - 'HOME': '/home/cltbld', 19:33:32 INFO - 'LANG': 'en_US.UTF-8', 19:33:32 INFO - 'LANGUAGE': 'en_US:en', 19:33:32 INFO - 'LOGNAME': 'cltbld', 19:33:32 INFO - 'MAIL': '/var/mail/cltbld', 19:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:32 INFO - 'MOZ_NO_REMOTE': '1', 19:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:32 INFO - 'NO_EM_RESTART': '1', 19:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:32 INFO - 'PWD': '/builds/slave/test', 19:33:32 INFO - 'SHELL': '/bin/bash', 19:33:32 INFO - 'SHLVL': '1', 19:33:32 INFO - 'TERM': 'linux', 19:33:32 INFO - 'TMOUT': '86400', 19:33:32 INFO - 'USER': 'cltbld', 19:33:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:32 INFO - '_': '/tools/buildbot/bin/python'} 19:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:33:32 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 19:33:32 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 19:33:32 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 19:33:32 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 19:33:32 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 19:33:32 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 19:33:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:33:34 INFO - Installing collected packages: mozsystemmonitor 19:33:34 INFO - Running setup.py install for mozsystemmonitor 19:33:34 INFO - Successfully installed mozsystemmonitor 19:33:34 INFO - Cleaning up... 19:33:34 INFO - Return code: 0 19:33:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:33:34 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')]} 19:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:34 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')]} 19:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:34 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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:34 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 19:33:34 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 19:33:34 INFO - Using env: {'DISPLAY': ':0', 19:33:34 INFO - 'HOME': '/home/cltbld', 19:33:34 INFO - 'LANG': 'en_US.UTF-8', 19:33:34 INFO - 'LANGUAGE': 'en_US:en', 19:33:34 INFO - 'LOGNAME': 'cltbld', 19:33:34 INFO - 'MAIL': '/var/mail/cltbld', 19:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:34 INFO - 'MOZ_NO_REMOTE': '1', 19:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:34 INFO - 'NO_EM_RESTART': '1', 19:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:34 INFO - 'PWD': '/builds/slave/test', 19:33:34 INFO - 'SHELL': '/bin/bash', 19:33:34 INFO - 'SHLVL': '1', 19:33:34 INFO - 'TERM': 'linux', 19:33:34 INFO - 'TMOUT': '86400', 19:33:34 INFO - 'USER': 'cltbld', 19:33:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:34 INFO - '_': '/tools/buildbot/bin/python'} 19:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:34 INFO - Downloading/unpacking jsonschema==2.5.1 19:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:33:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 19:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:33:37 INFO - warning: no files found matching '*.txt' 19:33:37 INFO - no previously-included directories found matching 'build' 19:33:37 INFO - no previously-included directories found matching 'dist' 19:33:37 INFO - no previously-included directories found matching '.git*' 19:33:37 INFO - Installing collected packages: jsonschema, functools32 19:33:37 INFO - Running setup.py install for functools32 19:33:37 INFO - warning: no files found matching '*.txt' 19:33:37 INFO - no previously-included directories found matching 'build' 19:33:37 INFO - no previously-included directories found matching 'dist' 19:33:37 INFO - no previously-included directories found matching '.git*' 19:33:37 INFO - Successfully installed jsonschema functools32 19:33:37 INFO - Cleaning up... 19:33:37 INFO - Return code: 0 19:33:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:33:37 INFO - Using env: {'DISPLAY': ':0', 19:33:37 INFO - 'HOME': '/home/cltbld', 19:33:37 INFO - 'LANG': 'en_US.UTF-8', 19:33:37 INFO - 'LANGUAGE': 'en_US:en', 19:33:37 INFO - 'LOGNAME': 'cltbld', 19:33:37 INFO - 'MAIL': '/var/mail/cltbld', 19:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:37 INFO - 'MOZ_NO_REMOTE': '1', 19:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:37 INFO - 'NO_EM_RESTART': '1', 19:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:37 INFO - 'PWD': '/builds/slave/test', 19:33:37 INFO - 'SHELL': '/bin/bash', 19:33:37 INFO - 'SHLVL': '1', 19:33:37 INFO - 'TERM': 'linux', 19:33:37 INFO - 'TMOUT': '86400', 19:33:37 INFO - 'USER': 'cltbld', 19:33:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:37 INFO - '_': '/tools/buildbot/bin/python'} 19:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:33:37 INFO - Cleaning up... 19:33:37 INFO - Return code: 0 19:33:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:33:37 INFO - Using env: {'DISPLAY': ':0', 19:33:37 INFO - 'HOME': '/home/cltbld', 19:33:37 INFO - 'LANG': 'en_US.UTF-8', 19:33:37 INFO - 'LANGUAGE': 'en_US:en', 19:33:37 INFO - 'LOGNAME': 'cltbld', 19:33:37 INFO - 'MAIL': '/var/mail/cltbld', 19:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:37 INFO - 'MOZ_NO_REMOTE': '1', 19:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:37 INFO - 'NO_EM_RESTART': '1', 19:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:37 INFO - 'PWD': '/builds/slave/test', 19:33:37 INFO - 'SHELL': '/bin/bash', 19:33:37 INFO - 'SHLVL': '1', 19:33:37 INFO - 'TERM': 'linux', 19:33:37 INFO - 'TMOUT': '86400', 19:33:37 INFO - 'USER': 'cltbld', 19:33:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:37 INFO - '_': '/tools/buildbot/bin/python'} 19:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:33:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:33:40 INFO - Downloading docopt-0.6.1.tar.gz 19:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:33:40 INFO - Running setup.py install for blobuploader 19:33:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:33:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:33:40 INFO - Running setup.py install for requests 19:33:40 INFO - Running setup.py install for docopt 19:33:40 INFO - Successfully installed blobuploader requests docopt 19:33:40 INFO - Cleaning up... 19:33:41 INFO - Return code: 0 19:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33: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')]} 19:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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')]} 19:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:41 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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:41 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 19:33:41 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 19:33:41 INFO - Using env: {'DISPLAY': ':0', 19:33:41 INFO - 'HOME': '/home/cltbld', 19:33:41 INFO - 'LANG': 'en_US.UTF-8', 19:33:41 INFO - 'LANGUAGE': 'en_US:en', 19:33:41 INFO - 'LOGNAME': 'cltbld', 19:33:41 INFO - 'MAIL': '/var/mail/cltbld', 19:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:41 INFO - 'MOZ_NO_REMOTE': '1', 19:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:41 INFO - 'NO_EM_RESTART': '1', 19:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:41 INFO - 'PWD': '/builds/slave/test', 19:33:41 INFO - 'SHELL': '/bin/bash', 19:33:41 INFO - 'SHLVL': '1', 19:33:41 INFO - 'TERM': 'linux', 19:33:41 INFO - 'TMOUT': '86400', 19:33:41 INFO - 'USER': 'cltbld', 19:33:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:41 INFO - '_': '/tools/buildbot/bin/python'} 19:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:41 INFO - Running setup.py (path:/tmp/pip-yCCIYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:41 INFO - Running setup.py (path:/tmp/pip-3uwAEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:41 INFO - Running setup.py (path:/tmp/pip-J8edJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:41 INFO - Running setup.py (path:/tmp/pip-ZVJ9RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:41 INFO - Running setup.py (path:/tmp/pip-gk1EXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:41 INFO - Running setup.py (path:/tmp/pip-0UScOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:41 INFO - Running setup.py (path:/tmp/pip-5QxMrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:41 INFO - Running setup.py (path:/tmp/pip-Xq09UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:41 INFO - Running setup.py (path:/tmp/pip-HHFKAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:41 INFO - Running setup.py (path:/tmp/pip-7Zjncl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:41 INFO - Running setup.py (path:/tmp/pip-l4OJJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:42 INFO - Running setup.py (path:/tmp/pip-sZg0ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:42 INFO - Running setup.py (path:/tmp/pip-Y4y04l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:42 INFO - Running setup.py (path:/tmp/pip-UbGf72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:42 INFO - Running setup.py (path:/tmp/pip-D8winX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:42 INFO - Running setup.py (path:/tmp/pip-PpopY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:42 INFO - Running setup.py (path:/tmp/pip-KprJ8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:33:42 INFO - Running setup.py install for manifestparser 19:33:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:33:42 INFO - Running setup.py install for mozcrash 19:33:42 INFO - Running setup.py install for mozdebug 19:33:42 INFO - Running setup.py install for mozdevice 19:33:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:33:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:33:42 INFO - Running setup.py install for mozfile 19:33:42 INFO - Running setup.py install for mozhttpd 19:33:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Running setup.py install for mozinfo 19:33:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Running setup.py install for mozInstall 19:33:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Running setup.py install for mozleak 19:33:43 INFO - Running setup.py install for mozlog 19:33:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Running setup.py install for moznetwork 19:33:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Running setup.py install for mozprocess 19:33:43 INFO - Running setup.py install for mozprofile 19:33:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Running setup.py install for mozrunner 19:33:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:33:43 INFO - Running setup.py install for mozscreenshot 19:33:44 INFO - Running setup.py install for moztest 19:33:44 INFO - Running setup.py install for mozversion 19:33:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:33:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:33:44 INFO - Cleaning up... 19:33:44 INFO - Return code: 0 19:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33: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')]} 19:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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')]} 19:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:44 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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:44 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 19:33:44 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 19:33:44 INFO - Using env: {'DISPLAY': ':0', 19:33:44 INFO - 'HOME': '/home/cltbld', 19:33:44 INFO - 'LANG': 'en_US.UTF-8', 19:33:44 INFO - 'LANGUAGE': 'en_US:en', 19:33:44 INFO - 'LOGNAME': 'cltbld', 19:33:44 INFO - 'MAIL': '/var/mail/cltbld', 19:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:44 INFO - 'MOZ_NO_REMOTE': '1', 19:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:44 INFO - 'NO_EM_RESTART': '1', 19:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:44 INFO - 'PWD': '/builds/slave/test', 19:33:44 INFO - 'SHELL': '/bin/bash', 19:33:44 INFO - 'SHLVL': '1', 19:33:44 INFO - 'TERM': 'linux', 19:33:44 INFO - 'TMOUT': '86400', 19:33:44 INFO - 'USER': 'cltbld', 19:33:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:44 INFO - '_': '/tools/buildbot/bin/python'} 19:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:44 INFO - Running setup.py (path:/tmp/pip-ecuix9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:44 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)) 19:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:44 INFO - Running setup.py (path:/tmp/pip-RWBPoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:44 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)) 19:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:44 INFO - Running setup.py (path:/tmp/pip-ewB7aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:44 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)) 19:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:44 INFO - Running setup.py (path:/tmp/pip-mvdv1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:44 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)) 19:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:44 INFO - Running setup.py (path:/tmp/pip-JaBjGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:44 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)) 19:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:44 INFO - Running setup.py (path:/tmp/pip-jf2pkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:44 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)) 19:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:44 INFO - Running setup.py (path:/tmp/pip-GeCIBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:44 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)) 19:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:44 INFO - Running setup.py (path:/tmp/pip-C0FSbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:45 INFO - Running setup.py (path:/tmp/pip-D3ZjnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:45 INFO - Running setup.py (path:/tmp/pip-4DYI92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:45 INFO - Running setup.py (path:/tmp/pip-I2Pwx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:45 INFO - Running setup.py (path:/tmp/pip-p6gOPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:45 INFO - Running setup.py (path:/tmp/pip-mitKYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:45 INFO - Running setup.py (path:/tmp/pip-eMMo8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:45 INFO - Running setup.py (path:/tmp/pip-11P_oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:45 INFO - Running setup.py (path:/tmp/pip-6D7gMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:45 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)) 19:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:45 INFO - Running setup.py (path:/tmp/pip-WA07IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:45 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)) 19:33:45 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)) 19:33:45 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)) 19:33:45 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)) 19:33:45 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)) 19:33:45 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)) 19:33:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:33:45 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 19:33:45 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 19:33:45 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 19:33:45 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 19:33:45 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 19:33:45 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 19:33:47 INFO - Downloading blessings-1.6.tar.gz 19:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:33:47 INFO - Installing collected packages: blessings 19:33:47 INFO - Running setup.py install for blessings 19:33:47 INFO - Successfully installed blessings 19:33:47 INFO - Cleaning up... 19:33:47 INFO - Return code: 0 19:33:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:33:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:47 INFO - Reading from file tmpfile_stdout 19:33:47 INFO - Current package versions: 19:33:47 INFO - argparse == 1.2.1 19:33:47 INFO - blessings == 1.6 19:33:47 INFO - blobuploader == 1.2.4 19:33:47 INFO - docopt == 0.6.1 19:33:47 INFO - functools32 == 3.2.3-2 19:33:47 INFO - jsonschema == 2.5.1 19:33:47 INFO - manifestparser == 1.1 19:33:47 INFO - mozInstall == 1.12 19:33:47 INFO - mozcrash == 0.17 19:33:47 INFO - mozdebug == 0.1 19:33:47 INFO - mozdevice == 0.48 19:33:47 INFO - mozfile == 1.2 19:33:47 INFO - mozhttpd == 0.7 19:33:47 INFO - mozinfo == 0.9 19:33:47 INFO - mozleak == 0.1 19:33:47 INFO - mozlog == 3.3 19:33:47 INFO - moznetwork == 0.27 19:33:47 INFO - mozprocess == 0.23 19:33:47 INFO - mozprofile == 0.28 19:33:47 INFO - mozrunner == 6.12 19:33:47 INFO - mozscreenshot == 0.1 19:33:47 INFO - mozsystemmonitor == 0.3 19:33:47 INFO - moztest == 0.7 19:33:47 INFO - mozversion == 1.4 19:33:47 INFO - psutil == 3.1.1 19:33:47 INFO - requests == 1.2.3 19:33:48 INFO - wsgiref == 0.1.2 19:33:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33: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')]} 19:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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')]} 19:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:48 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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:48 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 19:33:48 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 19:33:48 INFO - Using env: {'DISPLAY': ':0', 19:33:48 INFO - 'HOME': '/home/cltbld', 19:33:48 INFO - 'LANG': 'en_US.UTF-8', 19:33:48 INFO - 'LANGUAGE': 'en_US:en', 19:33:48 INFO - 'LOGNAME': 'cltbld', 19:33:48 INFO - 'MAIL': '/var/mail/cltbld', 19:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:48 INFO - 'MOZ_NO_REMOTE': '1', 19:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:48 INFO - 'NO_EM_RESTART': '1', 19:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:48 INFO - 'PWD': '/builds/slave/test', 19:33:48 INFO - 'SHELL': '/bin/bash', 19:33:48 INFO - 'SHLVL': '1', 19:33:48 INFO - 'TERM': 'linux', 19:33:48 INFO - 'TMOUT': '86400', 19:33:48 INFO - 'USER': 'cltbld', 19:33:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:48 INFO - '_': '/tools/buildbot/bin/python'} 19:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 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)) 19:33:48 INFO - Cleaning up... 19:33:48 INFO - Return code: 0 19:33:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:33: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')]} 19:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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')]} 19:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:48 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 0x2698030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2959180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', '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 19:33:48 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 19:33:48 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 19:33:48 INFO - Using env: {'DISPLAY': ':0', 19:33:48 INFO - 'HOME': '/home/cltbld', 19:33:48 INFO - 'LANG': 'en_US.UTF-8', 19:33:48 INFO - 'LANGUAGE': 'en_US:en', 19:33:48 INFO - 'LOGNAME': 'cltbld', 19:33:48 INFO - 'MAIL': '/var/mail/cltbld', 19:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:48 INFO - 'MOZ_NO_REMOTE': '1', 19:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:48 INFO - 'NO_EM_RESTART': '1', 19:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:48 INFO - 'PWD': '/builds/slave/test', 19:33:48 INFO - 'SHELL': '/bin/bash', 19:33:48 INFO - 'SHLVL': '1', 19:33:48 INFO - 'TERM': 'linux', 19:33:48 INFO - 'TMOUT': '86400', 19:33:48 INFO - 'USER': 'cltbld', 19:33:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:48 INFO - '_': '/tools/buildbot/bin/python'} 19:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:33:48 INFO - Cleaning up... 19:33:48 INFO - Return code: 0 19:33:48 INFO - Running post-action listener: _resource_record_post_action 19:33:48 INFO - Running post-action listener: _start_resource_monitoring 19:33:48 INFO - Starting resource monitoring. 19:33:48 INFO - [mozharness: 2016-07-30 02:33:48.481744Z] Finished create-virtualenv step (success) 19:33:48 INFO - [mozharness: 2016-07-30 02:33:48.482177Z] Running install step. 19:33:48 INFO - Running pre-action listener: _resource_record_pre_action 19:33:48 INFO - Running main action method: install 19:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:48 INFO - Reading from file tmpfile_stdout 19:33:48 INFO - Detecting whether we're running mozinstall >=1.0... 19:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:33:48 INFO - Reading from file tmpfile_stdout 19:33:48 INFO - Output received: 19:33:48 INFO - Usage: mozinstall [options] installer 19:33:48 INFO - Options: 19:33:48 INFO - -h, --help show this help message and exit 19:33:48 INFO - -d DEST, --destination=DEST 19:33:48 INFO - Directory to install application into. [default: 19:33:48 INFO - "/builds/slave/test"] 19:33:48 INFO - --app=APP Application being installed. [default: firefox] 19:33:48 INFO - mkdir: /builds/slave/test/build/application 19:33:48 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'] 19:33:48 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 19:34:05 INFO - Reading from file tmpfile_stdout 19:34:05 INFO - Output received: 19:34:05 INFO - /builds/slave/test/build/application/firefox/firefox 19:34:05 INFO - Running post-action listener: _resource_record_post_action 19:34:05 INFO - [mozharness: 2016-07-30 02:34:05.177840Z] Finished install step (success) 19:34:05 INFO - [mozharness: 2016-07-30 02:34:05.178113Z] Running run-tests step. 19:34:05 INFO - Running pre-action listener: _resource_record_pre_action 19:34:05 INFO - Running main action method: run_tests 19:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:34:05 INFO - Python 2.7.3 19:34:05 INFO - Return code: 0 19:34:05 INFO - grabbing minidump binary from tooltool 19:34:05 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')]} 19:34:05 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 0x29573b0>, '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 0x29582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2958740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:34:05 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 19:34:05 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 19:34:05 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 19:34:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:34:05 INFO - Return code: 0 19:34:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:34:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:34:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:34:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:34:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:34:05 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/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 19:34:05 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/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 19:34:05 INFO - Using env: {'DISPLAY': ':0', 19:34:05 INFO - 'HOME': '/home/cltbld', 19:34:05 INFO - 'LANG': 'en_US.UTF-8', 19:34:05 INFO - 'LANGUAGE': 'en_US:en', 19:34:05 INFO - 'LOGNAME': 'cltbld', 19:34:05 INFO - 'MAIL': '/var/mail/cltbld', 19:34:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:34:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:05 INFO - 'MOZ_NO_REMOTE': '1', 19:34:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:34:05 INFO - 'NO_EM_RESTART': '1', 19:34:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:05 INFO - 'PWD': '/builds/slave/test', 19:34:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:34:05 INFO - 'SHELL': '/bin/bash', 19:34:05 INFO - 'SHLVL': '1', 19:34:05 INFO - 'TERM': 'linux', 19:34:05 INFO - 'TMOUT': '86400', 19:34:05 INFO - 'USER': 'cltbld', 19:34:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290', 19:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:05 INFO - '_': '/tools/buildbot/bin/python'} 19:34:05 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/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 19:34:05 INFO - mozversion application_buildid: 20160729183225 19:34:05 INFO - mozversion application_changeset: 0cb2c7646aa072218accaf14615a2d4ba4408133 19:34:05 INFO - mozversion application_display_name: Nightly 19:34:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:34:05 INFO - mozversion application_name: Firefox 19:34:05 INFO - mozversion application_remotingname: firefox 19:34:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:34:05 INFO - mozversion application_vendor: Mozilla 19:34:05 INFO - mozversion application_version: 50.0a1 19:34:05 INFO - mozversion platform_buildid: 20160729183225 19:34:05 INFO - mozversion platform_changeset: 0cb2c7646aa072218accaf14615a2d4ba4408133 19:34:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:34:05 INFO - mozversion platform_version: 50.0a1 19:34:05 INFO - using testdate: 1469846045 19:34:05 INFO - actual date: 1469846045 19:34:05 INFO - starting webserver on 'localhost:41366' 19:34:05 INFO - SUITE-START | Running 2 tests 19:34:05 INFO - TEST-START | dromaeo_css 19:34:05 INFO - operating with platform_type : linux_ 19:34:05 INFO - Initialising browser for dromaeo_css test... 19:34:05 INFO - TEST-INFO | started process 7075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmy9ETJ/profile http://localhost:41366/getInfo.html) 19:34:09 INFO - PROCESS | 7075 | JavaScript error: , line 0: uncaught exception: undefined 19:34:10 INFO - PROCESS | 7075 | __metrics Screen width/height:1600/1200 19:34:10 INFO - PROCESS | 7075 | colorDepth:24 19:34:10 INFO - PROCESS | 7075 | Browser inner width/height: 1024/697 19:34:10 INFO - PROCESS | 7075 | __metrics 19:34:10 INFO - PROCESS | 7075 | 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" 19:34:10 INFO - PROCESS | 7075 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:34:11 INFO - TEST-INFO | 7075: exit 0 19:34:11 INFO - Browser initialized. 19:34:11 INFO - Running cycle 1/1 for dromaeo_css test... 19:34:11 INFO - TEST-INFO | started process 7153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmy9ETJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:34:23 INFO - PROCESS | 7153 | RSS: Main: 159293440 19:34:23 INFO - PROCESS | 7153 | 19:35:14 INFO - PROCESS | 7153 | 1469846114730 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] 19:37:28 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:41366/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41366/tests/dromaeo/cssquery-ext.html) 19:37:29 INFO - PROCESS | 7153 | RSS: Main: 239747072 19:37:29 INFO - PROCESS | 7153 | 19:40:31 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:41366/tests/dromaeo/cssquery-ext.html (next: http://localhost:41366/tests/dromaeo/cssquery-jquery.html) 19:40:32 INFO - PROCESS | 7153 | RSS: Main: 245506048 19:40:32 INFO - PROCESS | 7153 | 19:43:34 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:41366/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41366/tests/dromaeo/cssquery-mootools.html) 19:43:35 INFO - PROCESS | 7153 | RSS: Main: 187232256 19:43:35 INFO - PROCESS | 7153 | 19:46:37 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:41366/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41366/tests/dromaeo/cssquery-prototype.html) 19:46:38 INFO - PROCESS | 7153 | RSS: Main: 185909248 19:46:38 INFO - PROCESS | 7153 | 19:49:40 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:41366/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41366/tests/dromaeo/cssquery-yui.html) 19:49:41 INFO - PROCESS | 7153 | RSS: Main: 187060224 19:49:41 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:41366/tests/dromaeo/cssquery-yui.html (next: http://localhost:41366/tests/dromaeo/cssquery-dojo.html) 19:52:44 INFO - PROCESS | 7153 | RSS: Main: 277291008 19:52:44 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | __start_tp_report 19:52:44 INFO - PROCESS | 7153 | _x_x_mozilla_page_load 19:52:44 INFO - PROCESS | 7153 | _x_x_mozilla_page_load_details 19:52:44 INFO - PROCESS | 7153 | |i|pagename|runs| 19:52:44 INFO - PROCESS | 7153 | |0;dojo.html;2635.6968948570916;2640.3267166872442;2674.1175412114003;2675.1840688589973;2682.3830518980635;4660.277656963168;4715.198416269234;4727.747147006046;4832.66171368004;4848.442429120652;4707.293905914106;4757.1437141314545;4786.042791441708;4786.282057691348;4821.734804585746;4321.459817522809;4362.040351122764;4384.605385515303;4434.091011342667;4542.477615074259;4448.844290449835;4493.483249426309;4517.774111294422;4527.456705195381;4533.32000199971;4220.620144187038;4258.339957306623;4445.555444455561;4452.688311818174;4537.568930951555;4266.381374700651;4304.698671093025;4324.113556720896;4324.675649326313;4336.111097225062;4287.185434767384;4357.455318085239;4364.083542456088;4369.9126017479475;4412.227860124465;4644.744539050351;4757.976210118927;4767.904641907143;4804.111239420683;4812.494688057738;4976.402831660188;5068.4171320298265;5078.162103252959;5155.200943853709;5155.561777248939;5119.744012799345;5138.7173705446185;5171.689698618095;5175.792968281265;5187.144121219994;4584.77076146198;4774.665773395829;4785.49752276013;4821.108095002401;4832.347633069561;5173.974130129325;5256.159014557652;5265.236540701653;5272.420033796356;5277.102892508283;5042.4957504250015;5093.8726531836255;5094.719790411563;5095.592352611782;5099.184130539096;4980.975095124501;5123.897522049539;5175.0167468180925;5177.637565370464;5184.196449550251;5030.993801239767;5073.822416215415;5087;5117.2068329409;5145.511176438233;5078.339815823919;5080;5081.974590127025;5090.134677104901;5142.202958541432;4260.701750877471;4404.691671582958;4435.135148646047;4442.20040392726;4493.168763778646;3746.3256613809776;3809.561900381492;3866.4586957825927;3909.7458665186673;3961.069148750041;4439.134368798053;4467.329900514948;4471;4471.3516540102155;4513.616342610849;5180.9740951295;5192.324997750268;5192.7403629818355;5199.66202196856;5240.790368385298;4282.785860706952;4413.58070983256;4458.487273963471;4461.442319710036;4512.571305726016;4680.110778951988;4711.293306004127;4712.175369310357;4716.268978308368;4761.047790441926;4839.322494850794;4884.462709101996;4899;4901.240307752233;4943.802247910187;4949.876253093701;5070.112730272262;5106.157484015244;5134;5178.741062946762;4837.927431088466;4838.080764654846;4844.588210002048;4853;4870.561649451566;5034.773435195351;5039.3448851649055;5041.218611115283;5043.87390315245;5047.192449208109;4932.161532539549;5065.594752419871;5109.131447653982;5109.7700603472185;5161.432242453252;5005.324281221989;5008.57427118699;5009.949900500948;5028.296038554532;5039.84880453587;5013.498650134958;5024.346834911585;5024.371953505812;5027.949720502748;5065.214891691794;4711.31685905535;4807.831725889577;4830;4943.283223932438;5003.849884503471;4928.901421971612;4957.157283261926;4959.330490383896;4977.352944117387;4986.32684587576;4837.177679794514;4839.879003024953;4843.07981483517;4847.903041939071;4891.559759621651 19:52:44 INFO - PROCESS | 7153 | |1;ext.html;560.6923658494208;573.1603201310082;575.6833741442206;577.5235430769616;595.717034408656;26613.467730645374;38555.80722096389;39651.80174099133;39778.60221397785;39817;40050.39672421291;40479.392809107885;40581.18837623253;40589.79705101478;40644.59355406445;7695.769126926187;7831.334336581397;7841.725539606115;7842;7843.529388236696;7637.656305466267;7692.807679807994;7720.227977202291;7720.845583088335;7723.189065148163;7709.922900770976;7743.26438988298;7753.612319384037;7754.185810489902;7757.224277572254;7668.348190403766;7678.731244406475;7683.462157648967;7701.691932322757;7702.383809295243;7622.352100071501;7682.924390585323;7685.0777906651;7687.884681729778;7690.884636730453;38118.80940595307;38149.427758583646;38210;38319;38639.61360386416;2939.279876430267;3001.669816320225;3029.4849875521213;3162.6362968258713;3219.645838957713;28836;29063.709362906524;29101.854490727623;29269;30694.84652576723;2823.957640635392;2829.2078218098964;2846.985765071182;2859.3061060882674;2870.827750334966;251716;252385;252618.73690631613;254129;254204;45746.542534574895;45880.541194588295;45886.31170532445;45893.77053114713;45905.54094459079;31946.84026579852;32723;32837.83581082127;34937.65062349395;34978.30043399118;15148.318325675371;15328.770068448983;15338.616534586725;15339.53981380538;15349.693006139814;11610.76778464426;11697.2981621103;11724.179307448398;11725.4137293135;11727.472263748152;17836;17858.821411785717;17889.910550447163;17897;17915.835470694365;6772.187337519529;6804.795856124324;6866.759663411756;6942.618156001468;6952.687129079203;794.9562774047367;894.0389081737159;917.3761841947406;938.4175859058788;963.3786207895868;27425.772268319426;27524.862375687993;27548.586771198447;28192.43615127686;28423.431531369257;955.2978560757838;962.2638681408588;964.9372790768577;1011.7066050845319;1026.7381817636456;13918.51285205013;14662.853371466148;14886.776698349533;14904.776428353583;15079.773803392958;123212.38393807973;123593.38203308926;123654;123738;123841;47189;47684.7615761919;47686.76156619264;47763.28355074677;47829.28256076162;1174.747429302687;1191.195942738648;1197.784398808223;1208.1905123567408;1208.9697757555955;25905.222843314732;27017;27321.45357092807;27395.86302068477;27811.165665030083;42097.36853947132;42415;42499.36250956176;42503;42555.7872210637;312676;314050;314298;315611;315796;24883.502329953662;25146.874265628554;25519.74480255248;25568.488630227665;25597.488050238517;40845.79577102095;41309.58690413057;41907.371389428576;42004.78997604993;42032.57967420287;34133.92794648394;35064.47403289004;35116.29767404689;35338;35467.467987980715;34542.82728586441;35036.64963350334;35109.297814043064;35152.47271290881;35171.64828351786;28682.856585716938;30765.384692306478;35312;37410.25179496449;37735.62264377321;30150.54774178345;31607.813524630226;31802.363952720352;31988.520172197903;32070.35859282848;23314.417139570967;23800.642990354812;24077.277681669577;24089.156879509133;24177.153799616928 19:52:44 INFO - PROCESS | 7153 | |2;jquery.html;348.11752208152336;367.82160652083735;373.64130434782606;378.8333133421295;397.83887525552143;12674.936625316872;16134.838651613494;16206.189690515472;16666.58333541662;17689;16848;17099.145042747845;17166.742498862495;17299.82700172998;17409.65180696385;4912.312276281324;4956.107900577895;5214.191800270964;5243.764030618631;5250.6587071840395;3796.335641262782;5168;5250.474952504757;5862.50168735658;6191.195144631214;6190.442860142586;6222.5644204905675;6226.533010024244;6238.719257633417;6239.688015599225;6008.789692360769;6113.205283313163;6144.477719393857;6146;6152.077188421727;5167.431582525919;5346.759395827197;5380.892382152335;5385.272988146589;5387.353517577876;20164;20461.488462788402;20498.38504844857;20553.280635177845;20619.381418557317;1869.9252029918787;1992.3524854422371;1993.950151246216;2020.9494762630904;2044.3253726270295;12990.28553429561;13099.541516046893;13145.539906103337;13519.52681656147;14017.64955876101;1559.111306555264;1711.8117007129206;1757.0303600121451;1770.1680210301138;1798.1009495252374;52143.73928130373;70320.6483967582;71509.2849071513;72412.63793680997;72739;9545.665901693546;9708.854367184498;9732.562034708455;10007.699769006942;10086.092251697382;13467.191968481726;13475.663108422368;13549.45802167922;13553.728925421436;13556.389962451713;7612.657430415645;7617.438425122837;7752.302292793675;7790.961045194737;7818.257265559762;7234.095738032746;7310.378617817545;7315.817104572322;7463.104427468738;7473.4021278297605;6095.725692343766;6216.627002379872;6237.438630523275;6248.31268560458;6374.936250637435;1831.8168183181842;1839.2275244397117;1851.4630757080297;1852.2590963614662;1889.6882014467458;821.8150916043962;835.0939230934504;875.7241468937265;948.1798244518442;994.7314225159312;16641.6671666566;16929.66140677204;17392.913035434995;17589.472315830546;17793.644127117386;837.4640230252643;882.7572417585216;918.6784625381063;957.9616815327308;981.7398389426808;9799.069088436587;10112.292139550307;10295.536700848479;10318.948405257926;10339.844902326471;385647;388590;389805;424987;428247;79912.60043699744;81741;82812.58593707114;83068.58465707632;84325.57837210897;933.407286373158;943.8253923024125;990.4305024610877;994.8905620381752;995.1291571844886;15279.236038198267;15617.453389131326;15793.447229347377;15994.520164395086;16491.83508164903;26396.472070558866;26903;36948.89153325404;37935;40006.799965999984;53236.73381633067;53758.73120634372;54013;54398.45601543934;56344.43655563392;6738.9891516272955;6894.827629309308;6964.512484126062;7296.343329100407;7854.921450785419;10889.509972051119;12220.694482638006;12389.132760706663;12555.74888502243;12640.367981600699;10209.081182693593;10226.341151300865;10357.948210259203;10453.47732613351;10510.001549852752;10230.414285785715;10673;10712.57149714034;10855.782884342427;10924.563017479211;10166.745831354276;10419.791604168026;10656.8934310659;10899.400532970763;10975.670729878117;6892.310768923268;6970.756023539152;6975.232724400414;7018.052562904147;7474.140473845578;8266.710665126691;10576.41829699374;10601.204909631655;10610.310329828537;10747.623833165802 19:52:44 INFO - PROCESS | 7153 | |3;mootools.html;1222.2727477151102;1357.1721250037479;1401.5655146904458;1469.772185311277;1692.272322901152;6801.251862295144;7443.516171448859;7696.153423123452;7713.652885620139;7739.729109481169;7536.623168841564;7680.692772289101;7699.6150192490295;7859;7866.449348545604;2156.8382371322136;2205.0738689750265;2208.9668654970187;2209.2267706302746;2210.3037543173928;2120.936371908845;2141.957160856782;2194.5172062146303;2195.3304242206123;2196.604611169989;2157.946051348721;2161.070739581979;2162.91348346066;2174.521605246843;2194.7695491973354;2119.586680597284;2126.755423126345;2134.114342547841;2135.903884325209;2137.3801597536694;2080.2615071649498;2118.713973613573;2131.6163090643677;2132.2323963373174;2138.0378829526776;7717.073951125844;7747.186545412763;7772;7773.0672319321475;7819.882701759479;4567.497575266718;4777.474477807438;4805.8558243252755;4840.346553215341;4846.273059041172;2697.4874773792917;2795.0636536760207;2842.2468045967835;2845.1180134158476;2864.799464037518;810.7081450677811;816.8978877640295;825.7233826668013;825.9917400825975;832.2883934236262;10649.094826939641;10950.178736594788;10964.945175274152;10969.670909872717;10977.725556861062;4166.437530933285;4315.805788739514;4417.536158703354;4475.462944446687;4480.395146655225;9411.905880941104;9412.247020238501;9420.811583768285;9421.38760980534;9431.764205894908;4795.928061079087;4831.492693267156;4833.782479788418;4835.588974937099;4843.297721830385;3817.4846395736777;3929.2730844793805;4133.7106402551535;4394.516603173648;4399.5820397062225;3629.8003609801185;3663.670269675689;3746.587875333711;3760.2667479841716;3807.5430948286385;1182.8166634171716;1228.3121451986915;1233.993830030862;1243.5958313548133;1248.569243610971;776.1617453150584;780.5472825761045;783.7256960063932;790.237420888845;795.6697970342243;5153.613478989091;5273.630845840754;5374.516293533601;5404.594655400782;5497.45025497447;381.68129611773924;408.1897433594313;411.09353874706795;907.3013779389833;942.1708896171325;3571.1072231942017;3656.634336566322;3665.87169449068;3677.2093999790172;3681.871134510333;9552.90447095534;9804.313698041211;9905.059019393146;9925.1067403934;9938.055884690943;9804.411735295762;9824.066713662334;9919.752006199902;9920.305578609428;9933.850992235122;7337.963310183415;7395.445341599401;7517.774466766005;7518.624068796647;7520.1351844537485;5048.848534543969;5076.441591425014;5178.844634660966;5179.067767801681;5406.21609866575;8683.305335573265;8833.160849719266;8943.865842012505;8960.283177345927;9043.412178208395;8455.830883382176;8910.420822646507;9025.368224224241;9027.23268522183;9033.503157326148;6227.750889964532;6575.605463672195;6684.364985326386;6995.160580730345;7004.824879377852;7401.481896267425;7760.611969401621;7770.261825126604;7798.688052477837;7802.531848089133;6480.805575832733;6640.07039014548;6652.600843949379;6660.56706314088;6900.482463815334;6471.676416179266;6597.901031484435;6708.295628959084;6740.595564265964;6793.626350550767;6114.7554097837365;6212.565120441525;6222.253329600477;6223.751049957951;6234.1583886174785;4359.324304732771;4539.137563862855;4630.513796051366;4641.303804429363;4727.078219747116;4345.956540434681;4399.802008909543;4509.887252818706;4557.339185818104;4602.631789456902 19:52:44 INFO - PROCESS | 7153 | |4;prototype.html;308.50946994279093;310.11616891858205;311.85498743084463;315.0674004945362;315.3550988229071;4788.868953315776;4838.717739798956;4838.951610483894;4844.31140716902;4852.126617208905;4742.834000809972;4776.211925032374;4794.496577859327;4799.304100905375;4806.951930480703;3584.7311451641167;3706.314331848603;3727.7576957497677;3733.626637336272;3735.084904198475;3679.208970071434;3740.5137332146783;3764.1906989997146;3776.6412190841825;3840.7119466040017;3724.757890737107;3733.048072741447;3742.214135031633;3749.4563288323175;3780.7353485256044;3585.569731632195;3740.3267411865854;3742.419924911616;3774.2828862516035;3780;3358.6809253120914;3367.3433680432327;3372.561566996275;3385.9322813543836;3394.575678040245;4670.299455081731;4674.6209868089;4688.413948256468;4706.364640773486;4720.622350212009;4313.676474264443;4321.611055005064;4322.82708691652;4325.178216138924;4347.43483347166;4872.9756351218375;4962.982588569371;4966.453690094087;4981.651284410093;4990.176620857555;3664.743467957244;3668.578113516953;3679.797611131387;3686.189038411545;3704.444333349992;5222.033923724123;5231.869203269949;5234.476552344735;5271.757868910592;5275.86810329741;3683.797391143459;3747.8500859965297;3776.981115094462;3787.7879078695105;3803.2583646188727;3797.35444974355;3817.404165167657;3823.273578020223;3825.7895815730403;3833.4058220975794;4270.722403043792;4292.6995110342605;4292.91414171721;4307.612314891612;4316.352547117957;4815.277708343777;4934.901301974012;4987.875303117451;4997.625178111583;5017.071841709222;1290.3870661435742;1303.2115570080155;1304.341307639636;1305.693162106904;1308.4962289518603;849.7280870121625;864.7362554420962;877.144783835755;877.1491653096487;890.3544929925881;4192.916141677149;4317.805698743564;4452.465704115527;4483.932741008887;4487.6185524230805;5117.257997590328;5134.358205224347;5140.56305214061;5141.640085194001;5206.843794686166;4435.401220835146;4442.2009086320095;4445.533219012022;4453.487848897354;4456.286994080931;2605.905519681738;2685.5300322443495;2709.878055487508;2716.361655011071;2731.9180424587294;4782.187028205213;4833.709977401297;4837.854864354075;4839.225723884161;4844.685095468783;5083.949160508421;5195.6622819516615;5233.607479439057;5242.423333433319;5267.446103399507;4793.400824896888;4820.807167713322;4834.468208497063;4838.983813399225;4847.2729090636685;5067.6452648315735;5068.847934561822;5097.668651537638;5099.413567439792;5142.305788718475;4833.492483289345;5009.674371165863;5043.697378157322;5066.36670416198;5067.315912351933;4811.807527698853;4814.422269327703;4817.494163112823;4837.177679794373;4839.056384005226;3721.5534135903863;3722.236941427055;3722.9069273268383;3750.5499340079364;3759.285735710206;4982.7259500727805;5140.537351638371;5146.279520867157;5174.482551744795;5190.40310364313;4895.461499235153;4896.67789696787;4916.680415772963;4954.801807927643;4958.107540642574;4936.925946110883;4938;4948.480409556944;4957.603391728725;4971.154903666457;4752.144613969381;4902.117618828645;4903.5586797188425;4903.926441103315;4907.730074845917;4780.832670856504;4847.151748443937;4914.419929537022;4945.530174633404;4975.9004819902675;4909.975450122869;4917.262410638433;4920.926186107283;4925.8029678812445;4926 19:52:44 INFO - PROCESS | 7153 | |5;yui.html;552.9557635389167;593.8242280285036;599.9460048595631;671.254907053171;674.8481591641881;10666.62666806662;11362.715932101692;11372.431378431087;11438.428078596058;11440.71398215045;11318.886811131886;11345.546178152865;11604.187706860523;11714;11726.941365293162;769.2576663519702;789.2265579731866;791.2048391366698;791.3708601661692;791.7822598785323;632.1655414852397;761.1057008015587;781.5935713429013;786.4691333349995;789.72754399732;839.0895877972376;840.3277378097528;842.2209456252972;842.6966292134827;843.7890527368158;828.842519921213;830.9086000539996;831.1356189562847;831.9334453243725;832.0722394530115;492.57884508744866;499.6352662556318;501.7390956702494;503.8916632923939;584.360125662399;11750.059995200449;12069.094817888606;12078.939605301917;12084;12102;10685.198610104195;10711.464426778708;10920.617778377798;11280.943595282053;12324.630261092181;11379.146564007733;11460.14048946324;11460.541578336857;11727.53089876404;11819.409029548575;3969.3450580654157;3992.480977472939;4004.6796256299717;4027.7583344999393;4072.796360182009;61776.23418506574;63249;63784.68107659432;63826.36173638297;63967.36032639661;8830.779230519289;9010.774730631787;9045.185933265906;9066.592003359865;9239.676611318571;15149.318280677397;15154.469593564172;15165.772513412308;15180.848191518164;15188.392464301525;5735.053716136874;5990.34106248321;6157.941349641028;6248.281447633581;6337.9683101585115;3414.9146271343416;3468.479728040764;3489.94765078524;3507.210877552581;3524.013276282645;2657.9601305980427;2760.682521510012;2760.806743527974;2762.129929072336;2762.185155379128;473.97867095980763;476.68300580113834;482;490.6001608688907;504.8990201959549;419.50707918195997;486.7931129270046;538.7925648625229;543.1255678357841;553.4824938682345;6822.488313376517;7237.927620723831;7267.63661816907;7477.916312880811;7560.848783024308;511.3939981122382;527.7150338816996;528.9603279754034;529.2669652531272;531.8457647282322;3450.344434557426;3486.1981744198974;3505.772124811879;3517.278957813642;3783.1487915219404;48249.75875120672;48424.273635895486;54086;93278;93319.53340233391;48480;67805.66097169483;79808.20191798123;83387;85887.5705621468;42193.78903105465;43531.78234108873;44007;70277.64861175661;71683.28316716765;6596.571222870498;6685.598864068172;6759.594424334556;6816.454683625398;6885.001674757233;43794.781026094664;44359.77820110879;44428;45321.77339113283;46511.76744116258;56313;60467.39532604618;63479;63792.68103659452;65988;8457.873131902903;8845.203931646183;8986.19124278818;9040.186383225542;9242.306826987868;9593.856092158483;9723.124918757347;9772.560234789593;9775.169110625391;10259.538320775433;8775.489804078165;8829.911700882909;9076.137766912132;9340.392874463138;9548.522573871418;9082.727518174466;9200.6779762708;9246.121618446237;9354.251659867059;9721.9027809721;9146.268298536233;9275.72172834816;9509.144177024102;9668.129868311604;9980.650677226262;7526.278976322896;7710;7719.8070048247;7736.149023607286;7841.4118941078505;7481.139668938142;7889.960550197442;7906.723264685708;8010.118886922551;8144.185581441809 19:52:44 INFO - PROCESS | 7153 | __end_tp_report 19:52:44 INFO - PROCESS | 7153 | __start_cc_report 19:52:44 INFO - PROCESS | 7153 | _x_x_mozilla_cycle_collect,940 19:52:44 INFO - PROCESS | 7153 | __end_cc_report 19:52:44 INFO - PROCESS | 7153 | __startTimestamp1469847164520__endTimestamp 19:52:44 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | ------- Summary: start ------- 19:52:44 INFO - PROCESS | 7153 | Number of tests: 6 19:52:44 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | [#0] dojo.html Cycles:165 Average:4736.88 Median:4843.08 stddev:493.53 (10.2%) stddev-sans-first:466.70 19:52:44 INFO - PROCESS | 7153 | Values: 2635.7 2640.3 2674.1 2675.2 2682.4 4660.3 4715.2 4727.7 4832.7 4848.4 4707.3 4757.1 4786.0 4786.3 4821.7 4321.5 4362.0 4384.6 4434.1 4542.5 4448.8 4493.5 4517.8 4527.5 4533.3 4220.6 4258.3 4445.6 4452.7 4537.6 4266.4 4304.7 4324.1 4324.7 4336.1 4287.2 4357.5 4364.1 4369.9 4412.2 4644.7 4758.0 4767.9 4804.1 4812.5 4976.4 5068.4 5078.2 5155.2 5155.6 5119.7 5138.7 5171.7 5175.8 5187.1 4584.8 4774.7 4785.5 4821.1 4832.3 5174.0 5256.2 5265.2 5272.4 5277.1 5042.5 5093.9 5094.7 5095.6 5099.2 4981.0 5123.9 5175.0 5177.6 5184.2 5031.0 5073.8 5087.0 5117.2 5145.5 5078.3 5080.0 5082.0 5090.1 5142.2 4260.7 4404.7 4435.1 4442.2 4493.2 3746.3 3809.6 3866.5 3909.7 3961.1 4439.1 4467.3 4471.0 4471.4 4513.6 5181.0 5192.3 5192.7 5199.7 5240.8 4282.8 4413.6 4458.5 4461.4 4512.6 4680.1 4711.3 4712.2 4716.3 4761.0 4839.3 4884.5 4899.0 4901.2 4943.8 4949.9 5070.1 5106.2 5134.0 5178.7 4837.9 4838.1 4844.6 4853.0 4870.6 5034.8 5039.3 5041.2 5043.9 5047.2 4932.2 5065.6 5109.1 5109.8 5161.4 5005.3 5008.6 5009.9 5028.3 5039.8 5013.5 5024.3 5024.4 5027.9 5065.2 4711.3 4807.8 4830.0 4943.3 5003.8 4928.9 4957.2 4959.3 4977.4 4986.3 4837.2 4839.9 4843.1 4847.9 4891.6 19:52:44 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | [#1] ext.html Cycles:180 Average:38929.29 Median:34957.98 stddev:63998.55 (183.1%) stddev-sans-first:64113.24 19:52:44 INFO - PROCESS | 7153 | Values: 560.7 573.2 575.7 577.5 595.7 26613.5 38555.8 39651.8 39778.6 39817.0 40050.4 40479.4 40581.2 40589.8 40644.6 7695.8 7831.3 7841.7 7842.0 7843.5 7637.7 7692.8 7720.2 7720.8 7723.2 7709.9 7743.3 7753.6 7754.2 7757.2 7668.3 7678.7 7683.5 7701.7 7702.4 7622.4 7682.9 7685.1 7687.9 7690.9 38118.8 38149.4 38210.0 38319.0 38639.6 2939.3 3001.7 3029.5 3162.6 3219.6 28836.0 29063.7 29101.9 29269.0 30694.8 2824.0 2829.2 2847.0 2859.3 2870.8 251716.0 252385.0 252618.7 254129.0 254204.0 45746.5 45880.5 45886.3 45893.8 45905.5 31946.8 32723.0 32837.8 34937.7 34978.3 15148.3 15328.8 15338.6 15339.5 15349.7 11610.8 11697.3 11724.2 11725.4 11727.5 17836.0 17858.8 17889.9 17897.0 17915.8 6772.2 6804.8 6866.8 6942.6 6952.7 795.0 894.0 917.4 938.4 963.4 27425.8 27524.9 27548.6 28192.4 28423.4 955.3 962.3 964.9 1011.7 1026.7 13918.5 14662.9 14886.8 14904.8 15079.8 123212.4 123593.4 123654.0 123738.0 123841.0 47189.0 47684.8 47686.8 47763.3 47829.3 1174.7 1191.2 1197.8 1208.2 1209.0 25905.2 27017.0 27321.5 27395.9 27811.2 42097.4 42415.0 42499.4 42503.0 42555.8 312676.0 314050.0 314298.0 315611.0 315796.0 24883.5 25146.9 25519.7 25568.5 25597.5 40845.8 41309.6 41907.4 42004.8 42032.6 34133.9 35064.5 35116.3 35338.0 35467.5 34542.8 35036.6 35109.3 35152.5 35171.6 28682.9 30765.4 35312.0 37410.3 37735.6 30150.5 31607.8 31802.4 31988.5 32070.4 23314.4 23800.6 24077.3 24089.2 24177.2 19:52:44 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | [#2] jquery.html Cycles:180 Average:25037.26 Median:389197.50 stddev:66691.62 (17.1%) stddev-sans-first:66852.94 19:52:44 INFO - PROCESS | 7153 | Values: 348.1 367.8 373.6 378.8 397.8 12674.9 16134.8 16206.2 16666.6 17689.0 16848.0 17099.1 17166.7 17299.8 17409.7 4912.3 4956.1 5214.2 5243.8 5250.7 3796.3 5168.0 5250.5 5862.5 6191.2 6190.4 6222.6 6226.5 6238.7 6239.7 6008.8 6113.2 6144.5 6146.0 6152.1 5167.4 5346.8 5380.9 5385.3 5387.4 20164.0 20461.5 20498.4 20553.3 20619.4 1869.9 1992.4 1994.0 2020.9 2044.3 12990.3 13099.5 13145.5 13519.5 14017.6 1559.1 1711.8 1757.0 1770.2 1798.1 52143.7 70320.6 71509.3 72412.6 72739.0 9545.7 9708.9 9732.6 10007.7 10086.1 13467.2 13475.7 13549.5 13553.7 13556.4 7612.7 7617.4 7752.3 7791.0 7818.3 7234.1 7310.4 7315.8 7463.1 7473.4 6095.7 6216.6 6237.4 6248.3 6374.9 1831.8 1839.2 1851.5 1852.3 1889.7 821.8 835.1 875.7 948.2 994.7 16641.7 16929.7 17392.9 17589.5 17793.6 837.5 882.8 918.7 958.0 981.7 9799.1 10112.3 10295.5 10318.9 10339.8 385647.0 388590.0 389805.0 424987.0 428247.0 79912.6 81741.0 82812.6 83068.6 84325.6 933.4 943.8 990.4 994.9 995.1 15279.2 15617.5 15793.4 15994.5 16491.8 26396.5 26903.0 36948.9 37935.0 40006.8 53236.7 53758.7 54013.0 54398.5 56344.4 6739.0 6894.8 6964.5 7296.3 7854.9 10889.5 12220.7 12389.1 12555.7 12640.4 10209.1 10226.3 10357.9 10453.5 10510.0 10230.4 10673.0 10712.6 10855.8 10924.6 10166.7 10419.8 10656.9 10899.4 10975.7 6892.3 6970.8 6975.2 7018.1 7474.1 8266.7 10576.4 10601.2 10610.3 10747.6 19:52:44 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | [#3] mootools.html Cycles:180 Average:5158.44 Median:5166.23 stddev:2932.71 (56.8%) stddev-sans-first:2926.02 19:52:44 INFO - PROCESS | 7153 | Values: 1222.3 1357.2 1401.6 1469.8 1692.3 6801.3 7443.5 7696.2 7713.7 7739.7 7536.6 7680.7 7699.6 7859.0 7866.4 2156.8 2205.1 2209.0 2209.2 2210.3 2120.9 2142.0 2194.5 2195.3 2196.6 2157.9 2161.1 2162.9 2174.5 2194.8 2119.6 2126.8 2134.1 2135.9 2137.4 2080.3 2118.7 2131.6 2132.2 2138.0 7717.1 7747.2 7772.0 7773.1 7819.9 4567.5 4777.5 4805.9 4840.3 4846.3 2697.5 2795.1 2842.2 2845.1 2864.8 810.7 816.9 825.7 826.0 832.3 10649.1 10950.2 10964.9 10969.7 10977.7 4166.4 4315.8 4417.5 4475.5 4480.4 9411.9 9412.2 9420.8 9421.4 9431.8 4795.9 4831.5 4833.8 4835.6 4843.3 3817.5 3929.3 4133.7 4394.5 4399.6 3629.8 3663.7 3746.6 3760.3 3807.5 1182.8 1228.3 1234.0 1243.6 1248.6 776.2 780.5 783.7 790.2 795.7 5153.6 5273.6 5374.5 5404.6 5497.5 381.7 408.2 411.1 907.3 942.2 3571.1 3656.6 3665.9 3677.2 3681.9 9552.9 9804.3 9905.1 9925.1 9938.1 9804.4 9824.1 9919.8 9920.3 9933.9 7338.0 7395.4 7517.8 7518.6 7520.1 5048.8 5076.4 5178.8 5179.1 5406.2 8683.3 8833.2 8943.9 8960.3 9043.4 8455.8 8910.4 9025.4 9027.2 9033.5 6227.8 6575.6 6684.4 6995.2 7004.8 7401.5 7760.6 7770.3 7798.7 7802.5 6480.8 6640.1 6652.6 6660.6 6900.5 6471.7 6597.9 6708.3 6740.6 6793.6 6114.8 6212.6 6222.3 6223.8 6234.2 4359.3 4539.1 4630.5 4641.3 4727.1 4346.0 4399.8 4509.9 4557.3 4602.6 19:52:44 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | [#4] prototype.html Cycles:180 Average:4166.99 Median:4791.13 stddev:1188.22 (24.8%) stddev-sans-first:1155.72 19:52:44 INFO - PROCESS | 7153 | Values: 308.5 310.1 311.9 315.1 315.4 4788.9 4838.7 4839.0 4844.3 4852.1 4742.8 4776.2 4794.5 4799.3 4807.0 3584.7 3706.3 3727.8 3733.6 3735.1 3679.2 3740.5 3764.2 3776.6 3840.7 3724.8 3733.0 3742.2 3749.5 3780.7 3585.6 3740.3 3742.4 3774.3 3780.0 3358.7 3367.3 3372.6 3385.9 3394.6 4670.3 4674.6 4688.4 4706.4 4720.6 4313.7 4321.6 4322.8 4325.2 4347.4 4873.0 4963.0 4966.5 4981.7 4990.2 3664.7 3668.6 3679.8 3686.2 3704.4 5222.0 5231.9 5234.5 5271.8 5275.9 3683.8 3747.9 3777.0 3787.8 3803.3 3797.4 3817.4 3823.3 3825.8 3833.4 4270.7 4292.7 4292.9 4307.6 4316.4 4815.3 4934.9 4987.9 4997.6 5017.1 1290.4 1303.2 1304.3 1305.7 1308.5 849.7 864.7 877.1 877.1 890.4 4192.9 4317.8 4452.5 4483.9 4487.6 5117.3 5134.4 5140.6 5141.6 5206.8 4435.4 4442.2 4445.5 4453.5 4456.3 2605.9 2685.5 2709.9 2716.4 2731.9 4782.2 4833.7 4837.9 4839.2 4844.7 5083.9 5195.7 5233.6 5242.4 5267.4 4793.4 4820.8 4834.5 4839.0 4847.3 5067.6 5068.8 5097.7 5099.4 5142.3 4833.5 5009.7 5043.7 5066.4 5067.3 4811.8 4814.4 4817.5 4837.2 4839.1 3721.6 3722.2 3722.9 3750.5 3759.3 4982.7 5140.5 5146.3 5174.5 5190.4 4895.5 4896.7 4916.7 4954.8 4958.1 4936.9 4938.0 4948.5 4957.6 4971.2 4752.1 4902.1 4903.6 4903.9 4907.7 4780.8 4847.2 4914.4 4945.5 4975.9 4910.0 4917.3 4920.9 4925.8 4926.0 19:52:44 INFO - PROCESS | 7153 | 19:52:44 INFO - PROCESS | 7153 | [#5] yui.html Cycles:180 Average:15247.73 Median:33967.09 stddev:21729.03 (64.0%) stddev-sans-first:21761.97 19:52:44 INFO - PROCESS | 7153 | Values: 553.0 593.8 599.9 671.3 674.8 10666.6 11362.7 11372.4 11438.4 11440.7 11318.9 11345.5 11604.2 11714.0 11726.9 769.3 789.2 791.2 791.4 791.8 632.2 761.1 781.6 786.5 789.7 839.1 840.3 842.2 842.7 843.8 828.8 830.9 831.1 831.9 832.1 492.6 499.6 501.7 503.9 584.4 11750.1 12069.1 12078.9 12084.0 12102.0 10685.2 10711.5 10920.6 11280.9 12324.6 11379.1 11460.1 11460.5 11727.5 11819.4 3969.3 3992.5 4004.7 4027.8 4072.8 61776.2 63249.0 63784.7 63826.4 63967.4 8830.8 9010.8 9045.2 9066.6 9239.7 15149.3 15154.5 15165.8 15180.8 15188.4 5735.1 5990.3 6157.9 6248.3 6338.0 3414.9 3468.5 3489.9 3507.2 3524.0 2658.0 2760.7 2760.8 2762.1 2762.2 474.0 476.7 482.0 490.6 504.9 419.5 486.8 538.8 543.1 553.5 6822.5 7237.9 7267.6 7477.9 7560.8 511.4 527.7 529.0 529.3 531.8 3450.3 3486.2 3505.8 3517.3 3783.1 48249.8 48424.3 54086.0 93278.0 93319.5 48480.0 67805.7 79808.2 83387.0 85887.6 42193.8 43531.8 44007.0 70277.6 71683.3 6596.6 6685.6 6759.6 6816.5 6885.0 43794.8 44359.8 44428.0 45321.8 46511.8 56313.0 60467.4 63479.0 63792.7 65988.0 8457.9 8845.2 8986.2 9040.2 9242.3 9593.9 9723.1 9772.6 9775.2 10259.5 8775.5 8829.9 9076.1 9340.4 9548.5 9082.7 9200.7 9246.1 9354.3 9721.9 9146.3 9275.7 9509.1 9668.1 9980.7 7526.3 7710.0 7719.8 7736.1 7841.4 7481.1 7890.0 7906.7 8010.1 8144.2 19:52:44 INFO - PROCESS | 7153 | -------- Summary: end -------- 19:52:44 INFO - PROCESS | 7153 | 19:52:45 INFO - TEST-INFO | 7153: exit 0 19:52:45 INFO - TEST-OK | dromaeo_css | took 1119847ms 19:52:45 INFO - TEST-START | kraken 19:52:45 INFO - operating with platform_type : linux_ 19:52:45 INFO - Initialising browser for kraken test... 19:52:45 INFO - TEST-INFO | started process 7342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeau71Q/profile http://localhost:41366/getInfo.html) 19:52:48 INFO - PROCESS | 7342 | JavaScript error: , line 0: uncaught exception: undefined 19:52:49 INFO - PROCESS | 7342 | __metrics Screen width/height:1600/1200 19:52:49 INFO - PROCESS | 7342 | colorDepth:24 19:52:49 INFO - PROCESS | 7342 | Browser inner width/height: 1024/697 19:52:49 INFO - PROCESS | 7342 | __metrics 19:52:50 INFO - PROCESS | 7342 | 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" 19:52:50 INFO - PROCESS | 7342 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:51 INFO - PROCESS | 7342 | console.error: PushService: 19:52:51 INFO - PROCESS | 7342 | stateChangeProcessEnqueue: Error transitioning state 19:52:51 INFO - PROCESS | 7342 | UnknownError 19:52:51 INFO - TEST-INFO | 7342: exit 0 19:52:51 INFO - Browser initialized. 19:52:51 INFO - Running cycle 1/1 for kraken test... 19:52:51 INFO - TEST-INFO | started process 7423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeau71Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:53:03 INFO - PROCESS | 7423 | RSS: Main: 159068160 19:53:03 INFO - PROCESS | 7423 | 19:53:06 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41366/tests/kraken/driver.html?testName=audio-beat-detection) 19:53:07 INFO - PROCESS | 7423 | RSS: Main: 215568384 19:53:07 INFO - PROCESS | 7423 | 19:53:10 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41366/tests/kraken/driver.html?testName=audio-dft) 19:53:10 INFO - PROCESS | 7423 | RSS: Main: 193191936 19:53:10 INFO - PROCESS | 7423 | 19:53:13 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41366/tests/kraken/driver.html?testName=audio-fft) 19:53:14 INFO - PROCESS | 7423 | RSS: Main: 273600512 19:53:14 INFO - PROCESS | 7423 | 19:53:16 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41366/tests/kraken/driver.html?testName=audio-oscillator) 19:53:17 INFO - PROCESS | 7423 | RSS: Main: 182427648 19:53:17 INFO - PROCESS | 7423 | 19:53:19 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41366/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:53:20 INFO - PROCESS | 7423 | RSS: Main: 186535936 19:53:20 INFO - PROCESS | 7423 | 19:53:23 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41366/tests/kraken/driver.html?testName=imaging-darkroom) 19:53:23 INFO - PROCESS | 7423 | RSS: Main: 222908416 19:53:23 INFO - PROCESS | 7423 | 19:53:27 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41366/tests/kraken/driver.html?testName=imaging-desaturate) 19:53:28 INFO - PROCESS | 7423 | RSS: Main: 216432640 19:53:28 INFO - PROCESS | 7423 | 19:53:31 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41366/tests/kraken/driver.html?testName=json-parse-financial) 19:53:31 INFO - PROCESS | 7423 | RSS: Main: 220299264 19:53:31 INFO - PROCESS | 7423 | 19:53:33 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41366/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:53:33 INFO - PROCESS | 7423 | RSS: Main: 185876480 19:53:33 INFO - PROCESS | 7423 | 19:53:35 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41366/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:53:36 INFO - PROCESS | 7423 | RSS: Main: 191721472 19:53:36 INFO - PROCESS | 7423 | 19:53:38 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41366/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:53:39 INFO - PROCESS | 7423 | RSS: Main: 195641344 19:53:39 INFO - PROCESS | 7423 | 19:53:42 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:53:42 INFO - PROCESS | 7423 | RSS: Main: 190754816 19:53:42 INFO - PROCESS | 7423 | 19:53:45 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:53:46 INFO - PROCESS | 7423 | RSS: Main: 194379776 19:53:46 INFO - PROCESS | 7423 | 19:53:47 INFO - PROCESS | 7423 | Cycle 1(1): loaded http://localhost:41366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41366/tests/kraken/driver.html?testName=ai-astar) 19:53:48 INFO - PROCESS | 7423 | RSS: Main: 244916224 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | __start_tp_report 19:53:48 INFO - PROCESS | 7423 | _x_x_mozilla_page_load 19:53:48 INFO - PROCESS | 7423 | _x_x_mozilla_page_load_details 19:53:48 INFO - PROCESS | 7423 | |i|pagename|runs| 19:53:48 INFO - PROCESS | 7423 | |0;ai-astar;105;113;114;113;114;113;112;112;111;113 19:53:48 INFO - PROCESS | 7423 | |1;audio-beat-detection;148;122;125;185;125;130;148;124;197;128 19:53:48 INFO - PROCESS | 7423 | |2;audio-dft;162;161;162;161;161;161;160;161;162;161 19:53:48 INFO - PROCESS | 7423 | |3;audio-fft;75;77;76;117;77;77;76;75;105;77 19:53:48 INFO - PROCESS | 7423 | |4;audio-oscillator;85;86;128;85;85;87;123;86;85;122 19:53:48 INFO - PROCESS | 7423 | |5;imaging-gaussian-blur;117;117;116;117;117;116;118;116;117;117 19:53:48 INFO - PROCESS | 7423 | |6;imaging-darkroom;146;147;146;147;147;146;147;146;147;148 19:53:48 INFO - PROCESS | 7423 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 19:53:48 INFO - PROCESS | 7423 | |8;json-parse-financial;65;61;62;62;65;62;62;62;61;60 19:53:48 INFO - PROCESS | 7423 | |9;json-stringify-tinderbox;67;67;66;68;67;66;66;66;66;67 19:53:48 INFO - PROCESS | 7423 | |10;stanford-crypto-aes;79;80;79;80;79;79;79;79;81;82 19:53:48 INFO - PROCESS | 7423 | |11;stanford-crypto-ccm;132;129;130;146;131;129;130;138;161;147 19:53:48 INFO - PROCESS | 7423 | |12;stanford-crypto-pbkdf2;163;168;168;163;166;165;163;166;163;166 19:53:48 INFO - PROCESS | 7423 | |13;stanford-crypto-sha256-iterative;68;68;68;67;68;66;68;66;66;65 19:53:48 INFO - PROCESS | 7423 | __end_tp_report 19:53:48 INFO - PROCESS | 7423 | __start_cc_report 19:53:48 INFO - PROCESS | 7423 | _x_x_mozilla_cycle_collect,1980 19:53:48 INFO - PROCESS | 7423 | __end_cc_report 19:53:48 INFO - PROCESS | 7423 | __startTimestamp1469847228206__endTimestamp 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | ------- Summary: start ------- 19:53:48 INFO - PROCESS | 7423 | Number of tests: 14 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.62 (2.3%) stddev-sans-first:0.97 19:53:48 INFO - PROCESS | 7423 | Values: 105.0 113.0 114.0 113.0 114.0 113.0 112.0 112.0 111.0 113.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:139.00 stddev:27.03 (19.4%) stddev-sans-first:28.61 19:53:48 INFO - PROCESS | 7423 | Values: 148.0 122.0 125.0 185.0 125.0 130.0 148.0 124.0 197.0 128.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 19:53:48 INFO - PROCESS | 7423 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 160.0 161.0 162.0 161.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.50 stddev:14.94 (19.5%) stddev-sans-first:15.55 19:53:48 INFO - PROCESS | 7423 | Values: 75.0 77.0 76.0 117.0 77.0 77.0 76.0 75.0 105.0 77.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:85.00 stddev:18.80 (22.1%) stddev-sans-first:19.41 19:53:48 INFO - PROCESS | 7423 | Values: 85.0 86.0 128.0 85.0 85.0 87.0 123.0 86.0 85.0 122.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 19:53:48 INFO - PROCESS | 7423 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 118.0 116.0 117.0 117.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 19:53:48 INFO - PROCESS | 7423 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 148.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:53:48 INFO - PROCESS | 7423 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:1.62 (2.6%) stddev-sans-first:1.36 19:53:48 INFO - PROCESS | 7423 | Values: 65.0 61.0 62.0 62.0 65.0 62.0 62.0 62.0 61.0 60.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 19:53:48 INFO - PROCESS | 7423 | Values: 67.0 67.0 66.0 68.0 67.0 66.0 66.0 66.0 66.0 67.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:1.06 (1.3%) stddev-sans-first:1.09 19:53:48 INFO - PROCESS | 7423 | Values: 79.0 80.0 79.0 80.0 79.0 79.0 79.0 79.0 81.0 82.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:135.00 stddev:10.77 (8.0%) stddev-sans-first:11.25 19:53:48 INFO - PROCESS | 7423 | Values: 132.0 129.0 130.0 146.0 131.0 129.0 130.0 138.0 161.0 147.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:166.00 stddev:2.02 (1.2%) stddev-sans-first:2.00 19:53:48 INFO - PROCESS | 7423 | Values: 163.0 168.0 168.0 163.0 166.0 165.0 163.0 166.0 163.0 166.0 19:53:48 INFO - PROCESS | 7423 | 19:53:48 INFO - PROCESS | 7423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 19:53:48 INFO - PROCESS | 7423 | Values: 68.0 68.0 68.0 67.0 68.0 66.0 68.0 66.0 66.0 65.0 19:53:48 INFO - PROCESS | 7423 | -------- Summary: end -------- 19:53:48 INFO - PROCESS | 7423 | 19:53:49 INFO - TEST-INFO | 7423: exit 0 19:53:49 INFO - TEST-OK | kraken | took 63969ms 19:53:49 INFO - SUITE-END | took 1183s 19:53:49 INFO - Completed test suite (00:19:43) 19:53:49 INFO - javascript benchmark 19:53:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.6968948570916, 2640.3267166872442, 2674.1175412114003, 2675.1840688589973, 2682.3830518980635, 4660.277656963168, 4715.198416269234, 4727.747147006046, 4832.66171368004, 4848.442429120652, 4707.293905914106, 4757.1437141314545, 4786.042791441708, 4786.282057691348, 4821.734804585746, 4321.459817522809, 4362.040351122764, 4384.605385515303, 4434.091011342667, 4542.477615074259, 4448.844290449835, 4493.483249426309, 4517.774111294422, 4527.456705195381, 4533.32000199971, 4220.620144187038, 4258.339957306623, 4445.555444455561, 4452.688311818174, 4537.568930951555, 4266.381374700651, 4304.698671093025, 4324.113556720896, 4324.675649326313, 4336.111097225062, 4287.185434767384, 4357.455318085239, 4364.083542456088, 4369.9126017479475, 4412.227860124465, 4644.744539050351, 4757.976210118927, 4767.904641907143, 4804.111239420683, 4812.494688057738, 4976.402831660188, 5068.4171320298265, 5078.162103252959, 5155.200943853709, 5155.561777248939, 5119.744012799345, 5138.7173705446185, 5171.689698618095, 5175.792968281265, 5187.144121219994, 4584.77076146198, 4774.665773395829, 4785.49752276013, 4821.108095002401, 4832.347633069561, 5173.974130129325, 5256.159014557652, 5265.236540701653, 5272.420033796356, 5277.102892508283, 5042.4957504250015, 5093.8726531836255, 5094.719790411563, 5095.592352611782, 5099.184130539096, 4980.975095124501, 5123.897522049539, 5175.0167468180925, 5177.637565370464, 5184.196449550251, 5030.993801239767, 5073.822416215415, 5087.0, 5117.2068329409, 5145.511176438233, 5078.339815823919, 5080.0, 5081.974590127025, 5090.134677104901, 5142.202958541432, 4260.701750877471, 4404.691671582958, 4435.135148646047, 4442.20040392726, 4493.168763778646, 3746.3256613809776, 3809.561900381492, 3866.4586957825927, 3909.7458665186673, 3961.069148750041, 4439.134368798053, 4467.329900514948, 4471.0, 4471.3516540102155, 4513.616342610849, 5180.9740951295, 5192.324997750268, 5192.7403629818355, 5199.66202196856, 5240.790368385298, 4282.785860706952, 4413.58070983256, 4458.487273963471, 4461.442319710036, 4512.571305726016, 4680.110778951988, 4711.293306004127, 4712.175369310357, 4716.268978308368, 4761.047790441926, 4839.322494850794, 4884.462709101996, 4899.0, 4901.240307752233, 4943.802247910187, 4949.876253093701, 5070.112730272262, 5106.157484015244, 5134.0, 5178.741062946762, 4837.927431088466, 4838.080764654846, 4844.588210002048, 4853.0, 4870.561649451566, 5034.773435195351, 5039.3448851649055, 5041.218611115283, 5043.87390315245, 5047.192449208109, 4932.161532539549, 5065.594752419871, 5109.131447653982, 5109.7700603472185, 5161.432242453252, 5005.324281221989, 5008.57427118699, 5009.949900500948, 5028.296038554532, 5039.84880453587, 5013.498650134958, 5024.346834911585, 5024.371953505812, 5027.949720502748, 5065.214891691794, 4711.31685905535, 4807.831725889577, 4830.0, 4943.283223932438, 5003.849884503471, 4928.901421971612, 4957.157283261926, 4959.330490383896, 4977.352944117387, 4986.32684587576, 4837.177679794514, 4839.879003024953, 4843.07981483517, 4847.903041939071, 4891.559759621651], "value": 4705.489458315716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6923658494208, 573.1603201310082, 575.6833741442206, 577.5235430769616, 595.717034408656, 26613.467730645374, 38555.80722096389, 39651.80174099133, 39778.60221397785, 39817.0, 40050.39672421291, 40479.392809107885, 40581.18837623253, 40589.79705101478, 40644.59355406445, 7695.769126926187, 7831.334336581397, 7841.725539606115, 7842.0, 7843.529388236696, 7637.656305466267, 7692.807679807994, 7720.227977202291, 7720.845583088335, 7723.189065148163, 7709.922900770976, 7743.26438988298, 7753.612319384037, 7754.185810489902, 7757.224277572254, 7668.348190403766, 7678.731244406475, 7683.462157648967, 7701.691932322757, 7702.383809295243, 7622.352100071501, 7682.924390585323, 7685.0777906651, 7687.884681729778, 7690.884636730453, 38118.80940595307, 38149.427758583646, 38210.0, 38319.0, 38639.61360386416, 2939.279876430267, 3001.669816320225, 3029.4849875521213, 3162.6362968258713, 3219.645838957713, 28836.0, 29063.709362906524, 29101.854490727623, 29269.0, 30694.84652576723, 2823.957640635392, 2829.2078218098964, 2846.985765071182, 2859.3061060882674, 2870.827750334966, 251716.0, 252385.0, 252618.73690631613, 254129.0, 254204.0, 45746.542534574895, 45880.541194588295, 45886.31170532445, 45893.77053114713, 45905.54094459079, 31946.84026579852, 32723.0, 32837.83581082127, 34937.65062349395, 34978.30043399118, 15148.318325675371, 15328.770068448983, 15338.616534586725, 15339.53981380538, 15349.693006139814, 11610.76778464426, 11697.2981621103, 11724.179307448398, 11725.4137293135, 11727.472263748152, 17836.0, 17858.821411785717, 17889.910550447163, 17897.0, 17915.835470694365, 6772.187337519529, 6804.795856124324, 6866.759663411756, 6942.618156001468, 6952.687129079203, 794.9562774047367, 894.0389081737159, 917.3761841947406, 938.4175859058788, 963.3786207895868, 27425.772268319426, 27524.862375687993, 27548.586771198447, 28192.43615127686, 28423.431531369257, 955.2978560757838, 962.2638681408588, 964.9372790768577, 1011.7066050845319, 1026.7381817636456, 13918.51285205013, 14662.853371466148, 14886.776698349533, 14904.776428353583, 15079.773803392958, 123212.38393807973, 123593.38203308926, 123654.0, 123738.0, 123841.0, 47189.0, 47684.7615761919, 47686.76156619264, 47763.28355074677, 47829.28256076162, 1174.747429302687, 1191.195942738648, 1197.784398808223, 1208.1905123567408, 1208.9697757555955, 25905.222843314732, 27017.0, 27321.45357092807, 27395.86302068477, 27811.165665030083, 42097.36853947132, 42415.0, 42499.36250956176, 42503.0, 42555.7872210637, 312676.0, 314050.0, 314298.0, 315611.0, 315796.0, 24883.502329953662, 25146.874265628554, 25519.74480255248, 25568.488630227665, 25597.488050238517, 40845.79577102095, 41309.58690413057, 41907.371389428576, 42004.78997604993, 42032.57967420287, 34133.92794648394, 35064.47403289004, 35116.29767404689, 35338.0, 35467.467987980715, 34542.82728586441, 35036.64963350334, 35109.297814043064, 35152.47271290881, 35171.64828351786, 28682.856585716938, 30765.384692306478, 35312.0, 37410.25179496449, 37735.62264377321, 30150.54774178345, 31607.813524630226, 31802.363952720352, 31988.520172197903, 32070.35859282848, 23314.417139570967, 23800.642990354812, 24077.277681669577, 24089.156879509133, 24177.153799616928], "value": 16453.01346591442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.11752208152336, 367.82160652083735, 373.64130434782606, 378.8333133421295, 397.83887525552143, 12674.936625316872, 16134.838651613494, 16206.189690515472, 16666.58333541662, 17689.0, 16848.0, 17099.145042747845, 17166.742498862495, 17299.82700172998, 17409.65180696385, 4912.312276281324, 4956.107900577895, 5214.191800270964, 5243.764030618631, 5250.6587071840395, 3796.335641262782, 5168.0, 5250.474952504757, 5862.50168735658, 6191.195144631214, 6190.442860142586, 6222.5644204905675, 6226.533010024244, 6238.719257633417, 6239.688015599225, 6008.789692360769, 6113.205283313163, 6144.477719393857, 6146.0, 6152.077188421727, 5167.431582525919, 5346.759395827197, 5380.892382152335, 5385.272988146589, 5387.353517577876, 20164.0, 20461.488462788402, 20498.38504844857, 20553.280635177845, 20619.381418557317, 1869.9252029918787, 1992.3524854422371, 1993.950151246216, 2020.9494762630904, 2044.3253726270295, 12990.28553429561, 13099.541516046893, 13145.539906103337, 13519.52681656147, 14017.64955876101, 1559.111306555264, 1711.8117007129206, 1757.0303600121451, 1770.1680210301138, 1798.1009495252374, 52143.73928130373, 70320.6483967582, 71509.2849071513, 72412.63793680997, 72739.0, 9545.665901693546, 9708.854367184498, 9732.562034708455, 10007.699769006942, 10086.092251697382, 13467.191968481726, 13475.663108422368, 13549.45802167922, 13553.728925421436, 13556.389962451713, 7612.657430415645, 7617.438425122837, 7752.302292793675, 7790.961045194737, 7818.257265559762, 7234.095738032746, 7310.378617817545, 7315.817104572322, 7463.104427468738, 7473.4021278297605, 6095.725692343766, 6216.627002379872, 6237.438630523275, 6248.31268560458, 6374.936250637435, 1831.8168183181842, 1839.2275244397117, 1851.4630757080297, 1852.2590963614662, 1889.6882014467458, 821.8150916043962, 835.0939230934504, 875.7241468937265, 948.1798244518442, 994.7314225159312, 16641.6671666566, 16929.66140677204, 17392.913035434995, 17589.472315830546, 17793.644127117386, 837.4640230252643, 882.7572417585216, 918.6784625381063, 957.9616815327308, 981.7398389426808, 9799.069088436587, 10112.292139550307, 10295.536700848479, 10318.948405257926, 10339.844902326471, 385647.0, 388590.0, 389805.0, 424987.0, 428247.0, 79912.60043699744, 81741.0, 82812.58593707114, 83068.58465707632, 84325.57837210897, 933.407286373158, 943.8253923024125, 990.4305024610877, 994.8905620381752, 995.1291571844886, 15279.236038198267, 15617.453389131326, 15793.447229347377, 15994.520164395086, 16491.83508164903, 26396.472070558866, 26903.0, 36948.89153325404, 37935.0, 40006.799965999984, 53236.73381633067, 53758.73120634372, 54013.0, 54398.45601543934, 56344.43655563392, 6738.9891516272955, 6894.827629309308, 6964.512484126062, 7296.343329100407, 7854.921450785419, 10889.509972051119, 12220.694482638006, 12389.132760706663, 12555.74888502243, 12640.367981600699, 10209.081182693593, 10226.341151300865, 10357.948210259203, 10453.47732613351, 10510.001549852752, 10230.414285785715, 10673.0, 10712.57149714034, 10855.782884342427, 10924.563017479211, 10166.745831354276, 10419.791604168026, 10656.8934310659, 10899.400532970763, 10975.670729878117, 6892.310768923268, 6970.756023539152, 6975.232724400414, 7018.052562904147, 7474.140473845578, 8266.710665126691, 10576.41829699374, 10601.204909631655, 10610.310329828537, 10747.623833165802], "value": 8511.870276216134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.2727477151102, 1357.1721250037479, 1401.5655146904458, 1469.772185311277, 1692.272322901152, 6801.251862295144, 7443.516171448859, 7696.153423123452, 7713.652885620139, 7739.729109481169, 7536.623168841564, 7680.692772289101, 7699.6150192490295, 7859.0, 7866.449348545604, 2156.8382371322136, 2205.0738689750265, 2208.9668654970187, 2209.2267706302746, 2210.3037543173928, 2120.936371908845, 2141.957160856782, 2194.5172062146303, 2195.3304242206123, 2196.604611169989, 2157.946051348721, 2161.070739581979, 2162.91348346066, 2174.521605246843, 2194.7695491973354, 2119.586680597284, 2126.755423126345, 2134.114342547841, 2135.903884325209, 2137.3801597536694, 2080.2615071649498, 2118.713973613573, 2131.6163090643677, 2132.2323963373174, 2138.0378829526776, 7717.073951125844, 7747.186545412763, 7772.0, 7773.0672319321475, 7819.882701759479, 4567.497575266718, 4777.474477807438, 4805.8558243252755, 4840.346553215341, 4846.273059041172, 2697.4874773792917, 2795.0636536760207, 2842.2468045967835, 2845.1180134158476, 2864.799464037518, 810.7081450677811, 816.8978877640295, 825.7233826668013, 825.9917400825975, 832.2883934236262, 10649.094826939641, 10950.178736594788, 10964.945175274152, 10969.670909872717, 10977.725556861062, 4166.437530933285, 4315.805788739514, 4417.536158703354, 4475.462944446687, 4480.395146655225, 9411.905880941104, 9412.247020238501, 9420.811583768285, 9421.38760980534, 9431.764205894908, 4795.928061079087, 4831.492693267156, 4833.782479788418, 4835.588974937099, 4843.297721830385, 3817.4846395736777, 3929.2730844793805, 4133.7106402551535, 4394.516603173648, 4399.5820397062225, 3629.8003609801185, 3663.670269675689, 3746.587875333711, 3760.2667479841716, 3807.5430948286385, 1182.8166634171716, 1228.3121451986915, 1233.993830030862, 1243.5958313548133, 1248.569243610971, 776.1617453150584, 780.5472825761045, 783.7256960063932, 790.237420888845, 795.6697970342243, 5153.613478989091, 5273.630845840754, 5374.516293533601, 5404.594655400782, 5497.45025497447, 381.68129611773924, 408.1897433594313, 411.09353874706795, 907.3013779389833, 942.1708896171325, 3571.1072231942017, 3656.634336566322, 3665.87169449068, 3677.2093999790172, 3681.871134510333, 9552.90447095534, 9804.313698041211, 9905.059019393146, 9925.1067403934, 9938.055884690943, 9804.411735295762, 9824.066713662334, 9919.752006199902, 9920.305578609428, 9933.850992235122, 7337.963310183415, 7395.445341599401, 7517.774466766005, 7518.624068796647, 7520.1351844537485, 5048.848534543969, 5076.441591425014, 5178.844634660966, 5179.067767801681, 5406.21609866575, 8683.305335573265, 8833.160849719266, 8943.865842012505, 8960.283177345927, 9043.412178208395, 8455.830883382176, 8910.420822646507, 9025.368224224241, 9027.23268522183, 9033.503157326148, 6227.750889964532, 6575.605463672195, 6684.364985326386, 6995.160580730345, 7004.824879377852, 7401.481896267425, 7760.611969401621, 7770.261825126604, 7798.688052477837, 7802.531848089133, 6480.805575832733, 6640.07039014548, 6652.600843949379, 6660.56706314088, 6900.482463815334, 6471.676416179266, 6597.901031484435, 6708.295628959084, 6740.595564265964, 6793.626350550767, 6114.7554097837365, 6212.565120441525, 6222.253329600477, 6223.751049957951, 6234.1583886174785, 4359.324304732771, 4539.137563862855, 4630.513796051366, 4641.303804429363, 4727.078219747116, 4345.956540434681, 4399.802008909543, 4509.887252818706, 4557.339185818104, 4602.631789456902], "value": 4094.6902309364154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.50946994279093, 310.11616891858205, 311.85498743084463, 315.0674004945362, 315.3550988229071, 4788.868953315776, 4838.717739798956, 4838.951610483894, 4844.31140716902, 4852.126617208905, 4742.834000809972, 4776.211925032374, 4794.496577859327, 4799.304100905375, 4806.951930480703, 3584.7311451641167, 3706.314331848603, 3727.7576957497677, 3733.626637336272, 3735.084904198475, 3679.208970071434, 3740.5137332146783, 3764.1906989997146, 3776.6412190841825, 3840.7119466040017, 3724.757890737107, 3733.048072741447, 3742.214135031633, 3749.4563288323175, 3780.7353485256044, 3585.569731632195, 3740.3267411865854, 3742.419924911616, 3774.2828862516035, 3780.0, 3358.6809253120914, 3367.3433680432327, 3372.561566996275, 3385.9322813543836, 3394.575678040245, 4670.299455081731, 4674.6209868089, 4688.413948256468, 4706.364640773486, 4720.622350212009, 4313.676474264443, 4321.611055005064, 4322.82708691652, 4325.178216138924, 4347.43483347166, 4872.9756351218375, 4962.982588569371, 4966.453690094087, 4981.651284410093, 4990.176620857555, 3664.743467957244, 3668.578113516953, 3679.797611131387, 3686.189038411545, 3704.444333349992, 5222.033923724123, 5231.869203269949, 5234.476552344735, 5271.757868910592, 5275.86810329741, 3683.797391143459, 3747.8500859965297, 3776.981115094462, 3787.7879078695105, 3803.2583646188727, 3797.35444974355, 3817.404165167657, 3823.273578020223, 3825.7895815730403, 3833.4058220975794, 4270.722403043792, 4292.6995110342605, 4292.91414171721, 4307.612314891612, 4316.352547117957, 4815.277708343777, 4934.901301974012, 4987.875303117451, 4997.625178111583, 5017.071841709222, 1290.3870661435742, 1303.2115570080155, 1304.341307639636, 1305.693162106904, 1308.4962289518603, 849.7280870121625, 864.7362554420962, 877.144783835755, 877.1491653096487, 890.3544929925881, 4192.916141677149, 4317.805698743564, 4452.465704115527, 4483.932741008887, 4487.6185524230805, 5117.257997590328, 5134.358205224347, 5140.56305214061, 5141.640085194001, 5206.843794686166, 4435.401220835146, 4442.2009086320095, 4445.533219012022, 4453.487848897354, 4456.286994080931, 2605.905519681738, 2685.5300322443495, 2709.878055487508, 2716.361655011071, 2731.9180424587294, 4782.187028205213, 4833.709977401297, 4837.854864354075, 4839.225723884161, 4844.685095468783, 5083.949160508421, 5195.6622819516615, 5233.607479439057, 5242.423333433319, 5267.446103399507, 4793.400824896888, 4820.807167713322, 4834.468208497063, 4838.983813399225, 4847.2729090636685, 5067.6452648315735, 5068.847934561822, 5097.668651537638, 5099.413567439792, 5142.305788718475, 4833.492483289345, 5009.674371165863, 5043.697378157322, 5066.36670416198, 5067.315912351933, 4811.807527698853, 4814.422269327703, 4817.494163112823, 4837.177679794373, 4839.056384005226, 3721.5534135903863, 3722.236941427055, 3722.9069273268383, 3750.5499340079364, 3759.285735710206, 4982.7259500727805, 5140.537351638371, 5146.279520867157, 5174.482551744795, 5190.40310364313, 4895.461499235153, 4896.67789696787, 4916.680415772963, 4954.801807927643, 4958.107540642574, 4936.925946110883, 4938.0, 4948.480409556944, 4957.603391728725, 4971.154903666457, 4752.144613969381, 4902.117618828645, 4903.5586797188425, 4903.926441103315, 4907.730074845917, 4780.832670856504, 4847.151748443937, 4914.419929537022, 4945.530174633404, 4975.9004819902675, 4909.975450122869, 4917.262410638433, 4920.926186107283, 4925.8029678812445, 4926.0], "value": 3794.1637730866387, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9557635389167, 593.8242280285036, 599.9460048595631, 671.254907053171, 674.8481591641881, 10666.62666806662, 11362.715932101692, 11372.431378431087, 11438.428078596058, 11440.71398215045, 11318.886811131886, 11345.546178152865, 11604.187706860523, 11714.0, 11726.941365293162, 769.2576663519702, 789.2265579731866, 791.2048391366698, 791.3708601661692, 791.7822598785323, 632.1655414852397, 761.1057008015587, 781.5935713429013, 786.4691333349995, 789.72754399732, 839.0895877972376, 840.3277378097528, 842.2209456252972, 842.6966292134827, 843.7890527368158, 828.842519921213, 830.9086000539996, 831.1356189562847, 831.9334453243725, 832.0722394530115, 492.57884508744866, 499.6352662556318, 501.7390956702494, 503.8916632923939, 584.360125662399, 11750.059995200449, 12069.094817888606, 12078.939605301917, 12084.0, 12102.0, 10685.198610104195, 10711.464426778708, 10920.617778377798, 11280.943595282053, 12324.630261092181, 11379.146564007733, 11460.14048946324, 11460.541578336857, 11727.53089876404, 11819.409029548575, 3969.3450580654157, 3992.480977472939, 4004.6796256299717, 4027.7583344999393, 4072.796360182009, 61776.23418506574, 63249.0, 63784.68107659432, 63826.36173638297, 63967.36032639661, 8830.779230519289, 9010.774730631787, 9045.185933265906, 9066.592003359865, 9239.676611318571, 15149.318280677397, 15154.469593564172, 15165.772513412308, 15180.848191518164, 15188.392464301525, 5735.053716136874, 5990.34106248321, 6157.941349641028, 6248.281447633581, 6337.9683101585115, 3414.9146271343416, 3468.479728040764, 3489.94765078524, 3507.210877552581, 3524.013276282645, 2657.9601305980427, 2760.682521510012, 2760.806743527974, 2762.129929072336, 2762.185155379128, 473.97867095980763, 476.68300580113834, 482.0, 490.6001608688907, 504.8990201959549, 419.50707918195997, 486.7931129270046, 538.7925648625229, 543.1255678357841, 553.4824938682345, 6822.488313376517, 7237.927620723831, 7267.63661816907, 7477.916312880811, 7560.848783024308, 511.3939981122382, 527.7150338816996, 528.9603279754034, 529.2669652531272, 531.8457647282322, 3450.344434557426, 3486.1981744198974, 3505.772124811879, 3517.278957813642, 3783.1487915219404, 48249.75875120672, 48424.273635895486, 54086.0, 93278.0, 93319.53340233391, 48480.0, 67805.66097169483, 79808.20191798123, 83387.0, 85887.5705621468, 42193.78903105465, 43531.78234108873, 44007.0, 70277.64861175661, 71683.28316716765, 6596.571222870498, 6685.598864068172, 6759.594424334556, 6816.454683625398, 6885.001674757233, 43794.781026094664, 44359.77820110879, 44428.0, 45321.77339113283, 46511.76744116258, 56313.0, 60467.39532604618, 63479.0, 63792.68103659452, 65988.0, 8457.873131902903, 8845.203931646183, 8986.19124278818, 9040.186383225542, 9242.306826987868, 9593.856092158483, 9723.124918757347, 9772.560234789593, 9775.169110625391, 10259.538320775433, 8775.489804078165, 8829.911700882909, 9076.137766912132, 9340.392874463138, 9548.522573871418, 9082.727518174466, 9200.6779762708, 9246.121618446237, 9354.251659867059, 9721.9027809721, 9146.268298536233, 9275.72172834816, 9509.144177024102, 9668.129868311604, 9980.650677226262, 7526.278976322896, 7710.0, 7719.8070048247, 7736.149023607286, 7841.4118941078505, 7481.139668938142, 7889.960550197442, 7906.723264685708, 8010.118886922551, 8144.185581441809], "value": 5842.507036875958, "unit": "score"}], "name": "dromaeo_css", "value": 6253.789401288883, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 113.0, 114.0, 113.0, 112.0, 112.0, 111.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 125.0, 185.0, 125.0, 130.0, 148.0, 124.0, 197.0, 128.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 117.0, 77.0, 77.0, 76.0, 75.0, 105.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 128.0, 85.0, 85.0, 87.0, 123.0, 86.0, 85.0, 122.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 62.0, 62.0, 65.0, 62.0, 62.0, 62.0, 61.0, 60.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 81.0, 82.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 130.0, 146.0, 131.0, 129.0, 130.0, 138.0, 161.0, 147.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 168.0, 163.0, 166.0, 165.0, 163.0, 166.0, 163.0, 166.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 66.0, 68.0, 66.0, 66.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1533.1999999999998, "alertThreshold": 2.0}]} 19:53:49 INFO - Return code: 0 19:53:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:53:49 INFO - # TBPL SUCCESS # 19:53:49 INFO - Running post-action listener: _resource_record_post_action 19:53:49 INFO - [mozharness: 2016-07-30 02:53:49.496790Z] Finished run-tests step (success) 19:53:49 INFO - Running post-run listener: _resource_record_post_run 19:53:49 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 3305472; Write bytes: 301215744; Read time: 292; Write time: 222064 19:53:49 INFO - TinderboxPrint: CPU usage
13.0% 19:53:49 INFO - TinderboxPrint: I/O read bytes / time
3,305,472 / 292 19:53:49 INFO - TinderboxPrint: I/O write bytes / time
301,215,744 / 222,064 19:53:49 INFO - TinderboxPrint: CPU idle
8,334.8 (87.0%) 19:53:49 INFO - TinderboxPrint: CPU user
1,198.3 (12.5%) 19:53:49 INFO - TinderboxPrint: Swap in / out
0 / 0 19:53:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13914112; Read time: 0; Write time: 2192 19:53:49 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 3305472; Write bytes: 287301632; Read time: 292; Write time: 219872 19:53:50 INFO - Running post-run listener: _upload_blobber_files 19:53:50 INFO - Blob upload gear active. 19:53:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:53:50 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 19:53:50 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'] 19:53:50 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 19:53:50 INFO - (blobuploader) - INFO - Open directory for files ... 19:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:51 INFO - (blobuploader) - INFO - Done attempting. 19:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:51 INFO - (blobuploader) - INFO - Done attempting. 19:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:56 INFO - (blobuploader) - INFO - Done attempting. 19:53:56 INFO - (blobuploader) - INFO - Iteration through files over. 19:53:56 INFO - Return code: 0 19:53:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:53:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:53:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/544dd16c97e3d4020a10ba4b4447bb05e4a9bc8a56541c60df9aa7fc32bc8324bd158727881dab5808d37b94dae853c0de9802e4d63e78dcb2e47048cf364391", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7b1eb475e6140eec54e9a80e48f9e86387776deb3f7363ce90625db7797985ee7f7535300dee897b3d367f711d9ef8cbd84b7e9aeea7847e484a1a23d42503a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94736d6ab8e8e376ac4862bd2ee85972d8d981f9f7c12face657e90812a0355b81909299c121bfe8d24977c5fb77069356a9d00fa6865fa40f07ceb685a1a1cb"} 19:53:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:53:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:53:56 INFO - Contents: 19:53:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/544dd16c97e3d4020a10ba4b4447bb05e4a9bc8a56541c60df9aa7fc32bc8324bd158727881dab5808d37b94dae853c0de9802e4d63e78dcb2e47048cf364391", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7b1eb475e6140eec54e9a80e48f9e86387776deb3f7363ce90625db7797985ee7f7535300dee897b3d367f711d9ef8cbd84b7e9aeea7847e484a1a23d42503a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94736d6ab8e8e376ac4862bd2ee85972d8d981f9f7c12face657e90812a0355b81909299c121bfe8d24977c5fb77069356a9d00fa6865fa40f07ceb685a1a1cb"} 19:53:56 INFO - Running post-run listener: copy_logs_to_upload_dir 19:53:56 INFO - Copying logs to upload dir... 19:53:56 INFO - mkdir: /builds/slave/test/build/upload/logs 19:53:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.753531 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-29 19:53:55.973609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 19:53:55.977636) ========= 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=db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290 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/544dd16c97e3d4020a10ba4b4447bb05e4a9bc8a56541c60df9aa7fc32bc8324bd158727881dab5808d37b94dae853c0de9802e4d63e78dcb2e47048cf364391", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7b1eb475e6140eec54e9a80e48f9e86387776deb3f7363ce90625db7797985ee7f7535300dee897b3d367f711d9ef8cbd84b7e9aeea7847e484a1a23d42503a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94736d6ab8e8e376ac4862bd2ee85972d8d981f9f7c12face657e90812a0355b81909299c121bfe8d24977c5fb77069356a9d00fa6865fa40f07ceb685a1a1cb"} build_url:https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011097 build_url: 'https://queue.taskcluster.net/v1/task/QY1sduHGSuSaDKm-5WAypQ/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/544dd16c97e3d4020a10ba4b4447bb05e4a9bc8a56541c60df9aa7fc32bc8324bd158727881dab5808d37b94dae853c0de9802e4d63e78dcb2e47048cf364391", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7b1eb475e6140eec54e9a80e48f9e86387776deb3f7363ce90625db7797985ee7f7535300dee897b3d367f711d9ef8cbd84b7e9aeea7847e484a1a23d42503a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94736d6ab8e8e376ac4862bd2ee85972d8d981f9f7c12face657e90812a0355b81909299c121bfe8d24977c5fb77069356a9d00fa6865fa40f07ceb685a1a1cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 19:53:56.006335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:53:56.006837) ========= 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=db7e7c15f3ca076d53731445000001ba-1469845616.818410-1830287290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:53:56.088372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 19:53:56.088719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 19:53:56.089051) ========= ========= Total master_lag: 0.18 =========