builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1467826229.86 results: success (0) buildid: 20160706073423 builduid: d561b80e55da49529f455fb67012b9a1 revision: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:29.859591) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:29.860078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:29.860369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:29.876313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:29.876725) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 10:30:29-- 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% 55.4M=0s 2016-07-06 10:30:30 (55.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:29.990714) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:29.991052) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014781 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:30.040670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:30.041048) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d --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=9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 10:30:30,158 truncating revision to first 12 chars 2016-07-06 10:30:30,158 Setting DEBUG logging. 2016-07-06 10:30:30,158 attempt 1/10 2016-07-06 10:30:30,158 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/01a1714a1d04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 10:30:30,475 unpacking tar archive at: mozilla-beta-01a1714a1d04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:30.811767) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:30.812095) ========= script_repo_revision: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:30.812516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:30.812795) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 10:30:30.822561) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-07-06 10:30:30.822947) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:30:31 INFO - MultiFileLogger online at 20160706 10:30:31 in /builds/slave/test 10:30:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:30:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:30:31 INFO - {'append_to_log': False, 10:30:31 INFO - 'base_work_dir': '/builds/slave/test', 10:30:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:30:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:30:31 INFO - 'branch': 'Mozilla-Beta', 10:30:31 INFO - 'buildbot_json_path': 'buildprops.json', 10:30:31 INFO - 'config_files': ('talos/linux_config.py',), 10:30:31 INFO - 'default_actions': ('clobber', 10:30:31 INFO - 'read-buildbot-config', 10:30:31 INFO - 'download-and-extract', 10:30:31 INFO - 'populate-webroot', 10:30:31 INFO - 'create-virtualenv', 10:30:31 INFO - 'install', 10:30:31 INFO - 'run-tests'), 10:30:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:30:31 INFO - 'download_minidump_stackwalk': True, 10:30:31 INFO - 'download_symbols': 'ondemand', 10:30:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:30:31 INFO - 'tooltool.py': '/tools/tooltool.py', 10:30:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:30:31 INFO - '/tools/misc-python/virtualenv.py')}, 10:30:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:30:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:30:31 INFO - 'installer_path': 'installer.exe', 10:30:31 INFO - 'log_level': 'info', 10:30:31 INFO - 'log_name': 'talos', 10:30:31 INFO - 'log_to_console': True, 10:30:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:30:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:30:31 INFO - 'opt_config_files': (), 10:30:31 INFO - 'pip_index': False, 10:30:31 INFO - 'sps_profile': False, 10:30:31 INFO - 'sps_profile_interval': 0, 10:30:31 INFO - 'suite': 'dromaeojs', 10:30:31 INFO - 'system_bits': '32', 10:30:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:30:31 INFO - 'title': 'talos-linux64-ix-013', 10:30:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:30:31 INFO - 'use_talos_json': True, 10:30:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:30:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:30:31 INFO - 'work_dir': 'build'} 10:30:31 INFO - ##### 10:30:31 INFO - ##### Running clobber step. 10:30:31 INFO - ##### 10:30:31 INFO - Running pre-action listener: _resource_record_pre_action 10:30:31 INFO - Running main action method: clobber 10:30:31 INFO - rmtree: /builds/slave/test/build 10:30:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:30:32 INFO - Running post-action listener: _resource_record_post_action 10:30:32 INFO - ##### 10:30:32 INFO - ##### Running read-buildbot-config step. 10:30:32 INFO - ##### 10:30:32 INFO - Running pre-action listener: _resource_record_pre_action 10:30:32 INFO - Running main action method: read_buildbot_config 10:30:32 INFO - Using buildbot properties: 10:30:32 INFO - { 10:30:32 INFO - "project": "", 10:30:32 INFO - "product": "firefox", 10:30:32 INFO - "script_repo_revision": "production", 10:30:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:30:32 INFO - "repository": "", 10:30:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:30:32 INFO - "buildid": "20160706073423", 10:30:32 INFO - "pgo_build": "True", 10:30:32 INFO - "basedir": "/builds/slave/test", 10:30:32 INFO - "buildnumber": 93, 10:30:32 INFO - "slavename": "talos-linux64-ix-013", 10:30:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:30:32 INFO - "platform": "ubuntu64_hw", 10:30:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:30:32 INFO - "branch": "mozilla-beta", 10:30:32 INFO - "repo_path": "releases/mozilla-beta", 10:30:32 INFO - "revision": "01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d", 10:30:32 INFO - "stage_platform": "linux64-pgo", 10:30:32 INFO - "builduid": "d561b80e55da49529f455fb67012b9a1", 10:30:32 INFO - "slavebuilddir": "test" 10:30:32 INFO - } 10:30:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:30:32 INFO - Running post-action listener: _resource_record_post_action 10:30:32 INFO - ##### 10:30:32 INFO - ##### Running download-and-extract step. 10:30:32 INFO - ##### 10:30:32 INFO - Running pre-action listener: _resource_record_pre_action 10:30:32 INFO - Running main action method: download_and_extract 10:30:32 INFO - mkdir: /builds/slave/test/build/tests 10:30: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')]} 10:30:32 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:30:32 INFO - Downloaded 1327 bytes. 10:30:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:30:32 INFO - Using the following test package requirements: 10:30:32 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:30:32 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:30:32 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:30:32 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:30:32 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:30:32 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:30:32 INFO - u'jsshell-linux-x86_64.zip'], 10:30:32 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:30:32 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:30:32 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:30:32 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:30:32 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:30:32 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:30:32 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:30:32 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:30:32 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:30:32 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:30:32 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:30:32 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:30: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')]} 10:30:32 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:30:33 INFO - Downloaded 24237047 bytes. 10:30:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:30:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:30:35 INFO - Return code: 0 10:30:35 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:35 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:30:37 INFO - Downloaded 24237047 bytes. 10:30:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:30:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:30:38 INFO - Return code: 0 10:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:38 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:30:39 INFO - Downloaded 10840145 bytes. 10:30:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:30:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:30:40 INFO - Return code: 0 10:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:40 INFO - https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:30:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:30:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:30:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:30:41 INFO - Downloaded 56025129 bytes. 10:30:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:30:41 INFO - mkdir: /builds/slave/test/properties 10:30:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:30:41 INFO - Writing to file /builds/slave/test/properties/build_url 10:30:41 INFO - Contents: 10:30:41 INFO - build_url:https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:30:42 INFO - Running post-action listener: _resource_record_post_action 10:30:42 INFO - Running post-action listener: set_extra_try_arguments 10:30:42 INFO - ##### 10:30:42 INFO - ##### Running populate-webroot step. 10:30:42 INFO - ##### 10:30:42 INFO - Running pre-action listener: _resource_record_pre_action 10:30:42 INFO - Running main action method: populate_webroot 10:30:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:30:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:30:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:30:42 INFO - '--tppagecycles', 10:30:42 INFO - '7'], 10:30:42 INFO - 'tests': ['tsvgm']}}, 10:30:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:30:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:30:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:30:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:30:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:42 INFO - 'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:30:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:30:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:42 INFO - 'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['damp', 'tps']}, 10:30:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:42 INFO - 'tests': ['damp', 'tps']}, 10:30:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['dromaeo_dom']}, 10:30:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:30:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['a11yr', 10:30:42 INFO - 'ts_paint', 10:30:42 INFO - 'tpaint', 10:30:42 INFO - 'sessionrestore', 10:30:42 INFO - 'sessionrestore_no_auto_restore', 10:30:42 INFO - 'tabpaint']}, 10:30:42 INFO - 'other-e10s': {'tests': ['a11yr', 10:30:42 INFO - 'ts_paint', 10:30:42 INFO - 'tpaint', 10:30:42 INFO - 'sessionrestore', 10:30:42 INFO - 'sessionrestore_no_auto_restore', 10:30:42 INFO - 'tabpaint']}, 10:30:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:30:42 INFO - 'ts_paint', 10:30:42 INFO - 'tpaint', 10:30:42 INFO - 'sessionrestore', 10:30:42 INFO - 'sessionrestore_no_auto_restore', 10:30:42 INFO - 'tabpaint']}, 10:30:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:30:42 INFO - 'ts_paint', 10:30:42 INFO - 'tpaint', 10:30:42 INFO - 'sessionrestore', 10:30:42 INFO - 'sessionrestore_no_auto_restore', 10:30:42 INFO - 'tabpaint']}, 10:30:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['a11yr', 10:30:42 INFO - 'ts_paint', 10:30:42 INFO - 'tpaint', 10:30:42 INFO - 'sessionrestore', 10:30:42 INFO - 'sessionrestore_no_auto_restore', 10:30:42 INFO - 'tabpaint']}, 10:30:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['a11yr', 10:30:42 INFO - 'ts_paint', 10:30:42 INFO - 'tpaint', 10:30:42 INFO - 'sessionrestore', 10:30:42 INFO - 'sessionrestore_no_auto_restore', 10:30:42 INFO - 'tabpaint']}, 10:30:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['tsvgx', 10:30:42 INFO - 'tsvgr_opacity', 10:30:42 INFO - 'tart', 10:30:42 INFO - 'tscrollx', 10:30:42 INFO - 'cart']}, 10:30:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:30:42 INFO - 'tsvgr_opacity', 10:30:42 INFO - 'tart', 10:30:42 INFO - 'tscrollx', 10:30:42 INFO - 'cart']}, 10:30:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:42 INFO - 'talos_options': ['--disable-e10s'], 10:30:42 INFO - 'tests': ['tp5o']}, 10:30:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:42 INFO - 'tests': ['tp5o']}, 10:30:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:42 INFO - 'talos_options': ['--disable-e10s', 10:30:42 INFO - '--xperf_path', 10:30:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:30:42 INFO - 'tests': ['tp5n']}, 10:30:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:42 INFO - 'talos_options': ['--xperf_path', 10:30:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:30:42 INFO - 'tests': ['tp5n']}}, 10:30:42 INFO - 'talos.zip': {'path': '', 10:30:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:30:42 INFO - Running post-action listener: _resource_record_post_action 10:30:42 INFO - ##### 10:30:42 INFO - ##### Running create-virtualenv step. 10:30:42 INFO - ##### 10:30:42 INFO - Running pre-action listener: _resource_record_pre_action 10:30:42 INFO - Running main action method: create_virtualenv 10:30:42 INFO - Creating virtualenv /builds/slave/test/build/venv 10:30:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:30:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:30:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:30:42 INFO - Using real prefix '/usr' 10:30:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:30:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:30:44 INFO - Installing pip.................done. 10:30:44 INFO - Return code: 0 10:30:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:30: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')]} 10:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30: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')]} 10:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:44 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 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:30:44 INFO - Using env: {'DISPLAY': ':0', 10:30:44 INFO - 'HOME': '/home/cltbld', 10:30:44 INFO - 'LANG': 'en_US.UTF-8', 10:30:44 INFO - 'LANGUAGE': 'en_US:en', 10:30:44 INFO - 'LOGNAME': 'cltbld', 10:30:44 INFO - 'MAIL': '/var/mail/cltbld', 10:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:44 INFO - 'MOZ_NO_REMOTE': '1', 10:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:44 INFO - 'NO_EM_RESTART': '1', 10:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:44 INFO - 'PWD': '/builds/slave/test', 10:30:44 INFO - 'SHELL': '/bin/bash', 10:30:44 INFO - 'SHLVL': '1', 10:30:44 INFO - 'TERM': 'linux', 10:30:44 INFO - 'TMOUT': '86400', 10:30:44 INFO - 'USER': 'cltbld', 10:30:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:44 INFO - '_': '/tools/buildbot/bin/python'} 10:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:30:44 INFO - Cleaning up... 10:30:44 INFO - Return code: 0 10:30:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:30: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')]} 10:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30: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')]} 10:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:30:44 INFO - Using env: {'DISPLAY': ':0', 10:30:44 INFO - 'HOME': '/home/cltbld', 10:30:45 INFO - 'LANG': 'en_US.UTF-8', 10:30:45 INFO - 'LANGUAGE': 'en_US:en', 10:30:45 INFO - 'LOGNAME': 'cltbld', 10:30:45 INFO - 'MAIL': '/var/mail/cltbld', 10:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:45 INFO - 'MOZ_NO_REMOTE': '1', 10:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:45 INFO - 'NO_EM_RESTART': '1', 10:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:45 INFO - 'PWD': '/builds/slave/test', 10:30:45 INFO - 'SHELL': '/bin/bash', 10:30:45 INFO - 'SHLVL': '1', 10:30:45 INFO - 'TERM': 'linux', 10:30:45 INFO - 'TMOUT': '86400', 10:30:45 INFO - 'USER': 'cltbld', 10:30:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:45 INFO - '_': '/tools/buildbot/bin/python'} 10:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:45 INFO - Downloading/unpacking psutil>=0.7.1 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:30:47 INFO - Installing collected packages: psutil 10:30:47 INFO - Running setup.py install for psutil 10:30:47 INFO - building 'psutil._psutil_linux' extension 10:30:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:30:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:30:47 INFO - building 'psutil._psutil_posix' extension 10:30:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:30:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:30:47 INFO - Successfully installed psutil 10:30:47 INFO - Cleaning up... 10:30:47 INFO - Return code: 0 10:30:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:30:47 INFO - Using env: {'DISPLAY': ':0', 10:30:47 INFO - 'HOME': '/home/cltbld', 10:30:47 INFO - 'LANG': 'en_US.UTF-8', 10:30:47 INFO - 'LANGUAGE': 'en_US:en', 10:30:47 INFO - 'LOGNAME': 'cltbld', 10:30:47 INFO - 'MAIL': '/var/mail/cltbld', 10:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:47 INFO - 'MOZ_NO_REMOTE': '1', 10:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:47 INFO - 'NO_EM_RESTART': '1', 10:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:47 INFO - 'PWD': '/builds/slave/test', 10:30:47 INFO - 'SHELL': '/bin/bash', 10:30:47 INFO - 'SHLVL': '1', 10:30:47 INFO - 'TERM': 'linux', 10:30:47 INFO - 'TMOUT': '86400', 10:30:47 INFO - 'USER': 'cltbld', 10:30:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:47 INFO - '_': '/tools/buildbot/bin/python'} 10:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:30:50 INFO - Installing collected packages: mozsystemmonitor 10:30:50 INFO - Running setup.py install for mozsystemmonitor 10:30:50 INFO - Successfully installed mozsystemmonitor 10:30:50 INFO - Cleaning up... 10:30:50 INFO - Return code: 0 10:30:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:50 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 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:30:50 INFO - Using env: {'DISPLAY': ':0', 10:30:50 INFO - 'HOME': '/home/cltbld', 10:30:50 INFO - 'LANG': 'en_US.UTF-8', 10:30:50 INFO - 'LANGUAGE': 'en_US:en', 10:30:50 INFO - 'LOGNAME': 'cltbld', 10:30:50 INFO - 'MAIL': '/var/mail/cltbld', 10:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:50 INFO - 'MOZ_NO_REMOTE': '1', 10:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:50 INFO - 'NO_EM_RESTART': '1', 10:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:50 INFO - 'PWD': '/builds/slave/test', 10:30:50 INFO - 'SHELL': '/bin/bash', 10:30:50 INFO - 'SHLVL': '1', 10:30:50 INFO - 'TERM': 'linux', 10:30:50 INFO - 'TMOUT': '86400', 10:30:50 INFO - 'USER': 'cltbld', 10:30:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:50 INFO - '_': '/tools/buildbot/bin/python'} 10:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - Downloading blobuploader-1.2.4.tar.gz 10:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:30:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:30:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:53 INFO - Downloading docopt-0.6.1.tar.gz 10:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:30:53 INFO - Installing collected packages: blobuploader, requests, docopt 10:30:53 INFO - Running setup.py install for blobuploader 10:30:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:30:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:30:53 INFO - Running setup.py install for requests 10:30:53 INFO - Running setup.py install for docopt 10:30:53 INFO - Successfully installed blobuploader requests docopt 10:30:53 INFO - Cleaning up... 10:30:53 INFO - Return code: 0 10:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:53 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 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:30:53 INFO - Using env: {'DISPLAY': ':0', 10:30:53 INFO - 'HOME': '/home/cltbld', 10:30:53 INFO - 'LANG': 'en_US.UTF-8', 10:30:53 INFO - 'LANGUAGE': 'en_US:en', 10:30:53 INFO - 'LOGNAME': 'cltbld', 10:30:53 INFO - 'MAIL': '/var/mail/cltbld', 10:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:53 INFO - 'MOZ_NO_REMOTE': '1', 10:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:53 INFO - 'NO_EM_RESTART': '1', 10:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:53 INFO - 'PWD': '/builds/slave/test', 10:30:53 INFO - 'SHELL': '/bin/bash', 10:30:53 INFO - 'SHLVL': '1', 10:30:53 INFO - 'TERM': 'linux', 10:30:53 INFO - 'TMOUT': '86400', 10:30:53 INFO - 'USER': 'cltbld', 10:30:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:53 INFO - '_': '/tools/buildbot/bin/python'} 10:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:30:53 INFO - Running setup.py (path:/tmp/pip-5hspLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:30:54 INFO - Running setup.py (path:/tmp/pip-a6ZIzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:30:54 INFO - Running setup.py (path:/tmp/pip-TUrkYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:30:54 INFO - Running setup.py (path:/tmp/pip-BTEFZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:30:54 INFO - Running setup.py (path:/tmp/pip-WCKUWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:30:54 INFO - Running setup.py (path:/tmp/pip-hjLp1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:30:54 INFO - Running setup.py (path:/tmp/pip-xA_fDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:30:54 INFO - Running setup.py (path:/tmp/pip-tFCzZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:30:54 INFO - Running setup.py (path:/tmp/pip-umeO8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:30:54 INFO - Running setup.py (path:/tmp/pip-xTrdif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:30:54 INFO - Running setup.py (path:/tmp/pip-JRDKIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:30:54 INFO - Running setup.py (path:/tmp/pip-9B9QE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:30:54 INFO - Running setup.py (path:/tmp/pip-MptX3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:30:54 INFO - Running setup.py (path:/tmp/pip-5Jlj4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:30:54 INFO - Running setup.py (path:/tmp/pip-cuq4NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:30:55 INFO - Running setup.py (path:/tmp/pip-NrRiCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:30:55 INFO - Running setup.py (path:/tmp/pip-gAFDa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:30:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:30:55 INFO - Running setup.py install for manifestparser 10:30:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Running setup.py install for mozcrash 10:30:55 INFO - Running setup.py install for mozdebug 10:30:55 INFO - Running setup.py install for mozdevice 10:30:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Running setup.py install for mozfile 10:30:55 INFO - Running setup.py install for mozhttpd 10:30:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Running setup.py install for mozinfo 10:30:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Running setup.py install for mozInstall 10:30:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:30:55 INFO - Running setup.py install for mozleak 10:30:56 INFO - Running setup.py install for mozlog 10:30:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:30:56 INFO - Running setup.py install for moznetwork 10:30:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:30:56 INFO - Running setup.py install for mozprocess 10:30:56 INFO - Running setup.py install for mozprofile 10:30:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:30:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:30:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:30:56 INFO - Running setup.py install for mozrunner 10:30:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:30:56 INFO - Running setup.py install for mozscreenshot 10:30:56 INFO - Running setup.py install for moztest 10:30:56 INFO - Running setup.py install for mozversion 10:30:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:30:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:30:56 INFO - Cleaning up... 10:30:56 INFO - Return code: 0 10:30:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:56 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 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:30:56 INFO - Using env: {'DISPLAY': ':0', 10:30:56 INFO - 'HOME': '/home/cltbld', 10:30:56 INFO - 'LANG': 'en_US.UTF-8', 10:30:56 INFO - 'LANGUAGE': 'en_US:en', 10:30:56 INFO - 'LOGNAME': 'cltbld', 10:30:56 INFO - 'MAIL': '/var/mail/cltbld', 10:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:56 INFO - 'MOZ_NO_REMOTE': '1', 10:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:56 INFO - 'NO_EM_RESTART': '1', 10:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:56 INFO - 'PWD': '/builds/slave/test', 10:30:56 INFO - 'SHELL': '/bin/bash', 10:30:56 INFO - 'SHLVL': '1', 10:30:56 INFO - 'TERM': 'linux', 10:30:56 INFO - 'TMOUT': '86400', 10:30:56 INFO - 'USER': 'cltbld', 10:30:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:56 INFO - '_': '/tools/buildbot/bin/python'} 10:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:30:57 INFO - Running setup.py (path:/tmp/pip-pveDOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:30:57 INFO - Running setup.py (path:/tmp/pip-UIuN9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:30:57 INFO - Running setup.py (path:/tmp/pip-MjyBot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:30:57 INFO - Running setup.py (path:/tmp/pip-eE_EyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:30:57 INFO - Running setup.py (path:/tmp/pip-NUOEQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:30:57 INFO - Running setup.py (path:/tmp/pip-dEkUAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:30:57 INFO - Running setup.py (path:/tmp/pip-kVGq7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:30:57 INFO - Running setup.py (path:/tmp/pip-8aIqhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:30:57 INFO - Running setup.py (path:/tmp/pip-yLwAgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:30:57 INFO - Running setup.py (path:/tmp/pip-MSoppq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:30:57 INFO - Running setup.py (path:/tmp/pip-np_vmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:30:57 INFO - Running setup.py (path:/tmp/pip-aumUaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:30:58 INFO - Running setup.py (path:/tmp/pip-VBB7iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:30:58 INFO - Running setup.py (path:/tmp/pip-4c1Bzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:30:58 INFO - Running setup.py (path:/tmp/pip-eN2oCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:30:58 INFO - Running setup.py (path:/tmp/pip-27dnA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:30:58 INFO - Running setup.py (path:/tmp/pip-mFSZun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:30:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:00 INFO - Downloading blessings-1.6.tar.gz 10:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:31:00 INFO - Installing collected packages: blessings 10:31:00 INFO - Running setup.py install for blessings 10:31:00 INFO - Successfully installed blessings 10:31:00 INFO - Cleaning up... 10:31:00 INFO - Return code: 0 10:31:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:31:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:00 INFO - Reading from file tmpfile_stdout 10:31:00 INFO - Current package versions: 10:31:00 INFO - argparse == 1.2.1 10:31:00 INFO - blessings == 1.6 10:31:00 INFO - blobuploader == 1.2.4 10:31:00 INFO - docopt == 0.6.1 10:31:00 INFO - manifestparser == 1.1 10:31:00 INFO - mozInstall == 1.12 10:31:00 INFO - mozcrash == 0.17 10:31:00 INFO - mozdebug == 0.1 10:31:00 INFO - mozdevice == 0.48 10:31:00 INFO - mozfile == 1.2 10:31:00 INFO - mozhttpd == 0.7 10:31:00 INFO - mozinfo == 0.9 10:31:00 INFO - mozleak == 0.1 10:31:00 INFO - mozlog == 3.1 10:31:00 INFO - moznetwork == 0.27 10:31:00 INFO - mozprocess == 0.22 10:31:00 INFO - mozprofile == 0.28 10:31:00 INFO - mozrunner == 6.11 10:31:00 INFO - mozscreenshot == 0.1 10:31:00 INFO - mozsystemmonitor == 0.0 10:31:00 INFO - moztest == 0.7 10:31:00 INFO - mozversion == 1.4 10:31:00 INFO - psutil == 3.1.1 10:31:00 INFO - requests == 1.2.3 10:31:00 INFO - wsgiref == 0.1.2 10:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:00 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 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:31:00 INFO - Using env: {'DISPLAY': ':0', 10:31:00 INFO - 'HOME': '/home/cltbld', 10:31:00 INFO - 'LANG': 'en_US.UTF-8', 10:31:00 INFO - 'LANGUAGE': 'en_US:en', 10:31:00 INFO - 'LOGNAME': 'cltbld', 10:31:00 INFO - 'MAIL': '/var/mail/cltbld', 10:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:00 INFO - 'MOZ_NO_REMOTE': '1', 10:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:00 INFO - 'NO_EM_RESTART': '1', 10:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:00 INFO - 'PWD': '/builds/slave/test', 10:31:00 INFO - 'SHELL': '/bin/bash', 10:31:00 INFO - 'SHLVL': '1', 10:31:00 INFO - 'TERM': 'linux', 10:31:00 INFO - 'TMOUT': '86400', 10:31:00 INFO - 'USER': 'cltbld', 10:31:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:00 INFO - '_': '/tools/buildbot/bin/python'} 10:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:31:00 INFO - Cleaning up... 10:31:00 INFO - Return code: 0 10:31:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:31:00 INFO - Using env: {'DISPLAY': ':0', 10:31:00 INFO - 'HOME': '/home/cltbld', 10:31:00 INFO - 'LANG': 'en_US.UTF-8', 10:31:00 INFO - 'LANGUAGE': 'en_US:en', 10:31:00 INFO - 'LOGNAME': 'cltbld', 10:31:00 INFO - 'MAIL': '/var/mail/cltbld', 10:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:00 INFO - 'MOZ_NO_REMOTE': '1', 10:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:00 INFO - 'NO_EM_RESTART': '1', 10:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:00 INFO - 'PWD': '/builds/slave/test', 10:31:00 INFO - 'SHELL': '/bin/bash', 10:31:00 INFO - 'SHLVL': '1', 10:31:00 INFO - 'TERM': 'linux', 10:31:00 INFO - 'TMOUT': '86400', 10:31:00 INFO - 'USER': 'cltbld', 10:31:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:00 INFO - '_': '/tools/buildbot/bin/python'} 10:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:01 INFO - Downloading/unpacking jsonschema 10:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:31:03 INFO - Downloading/unpacking functools32 (from jsonschema) 10:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:03 INFO - Downloading functools32-3.2.3-2.tar.gz 10:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:31:03 INFO - warning: no files found matching '*.txt' 10:31:03 INFO - no previously-included directories found matching 'build' 10:31:03 INFO - no previously-included directories found matching 'dist' 10:31:03 INFO - no previously-included directories found matching '.git*' 10:31:03 INFO - Installing collected packages: jsonschema, functools32 10:31:03 INFO - Running setup.py install for functools32 10:31:03 INFO - warning: no files found matching '*.txt' 10:31:03 INFO - no previously-included directories found matching 'build' 10:31:03 INFO - no previously-included directories found matching 'dist' 10:31:03 INFO - no previously-included directories found matching '.git*' 10:31:03 INFO - Successfully installed jsonschema functools32 10:31:03 INFO - Cleaning up... 10:31:03 INFO - Return code: 0 10:31:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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')]} 10:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e1d5c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16395a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:31:03 INFO - Using env: {'DISPLAY': ':0', 10:31:03 INFO - 'HOME': '/home/cltbld', 10:31:03 INFO - 'LANG': 'en_US.UTF-8', 10:31:03 INFO - 'LANGUAGE': 'en_US:en', 10:31:03 INFO - 'LOGNAME': 'cltbld', 10:31:03 INFO - 'MAIL': '/var/mail/cltbld', 10:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:03 INFO - 'MOZ_NO_REMOTE': '1', 10:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:03 INFO - 'NO_EM_RESTART': '1', 10:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:03 INFO - 'PWD': '/builds/slave/test', 10:31:03 INFO - 'SHELL': '/bin/bash', 10:31:03 INFO - 'SHLVL': '1', 10:31:03 INFO - 'TERM': 'linux', 10:31:03 INFO - 'TMOUT': '86400', 10:31:03 INFO - 'USER': 'cltbld', 10:31:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:03 INFO - '_': '/tools/buildbot/bin/python'} 10:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:03 INFO - Downloading/unpacking flake8 10:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:31:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:31:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:31:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:31:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:31:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:31:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:31:06 INFO - no previously-included directories found matching 'docs/_build' 10:31:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:31:06 INFO - Running setup.py install for pep8 10:31:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:31:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:31:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:31:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:31:06 INFO - no previously-included directories found matching 'docs/_build' 10:31:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:31:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:31:06 INFO - Cleaning up... 10:31:06 INFO - Return code: 0 10:31:06 INFO - Running post-action listener: _resource_record_post_action 10:31:06 INFO - Running post-action listener: _start_resource_monitoring 10:31:06 INFO - Starting resource monitoring. 10:31:06 INFO - ##### 10:31:06 INFO - ##### Running install step. 10:31:06 INFO - ##### 10:31:06 INFO - Running pre-action listener: _resource_record_pre_action 10:31:06 INFO - Running main action method: install 10:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:06 INFO - Reading from file tmpfile_stdout 10:31:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:31:07 INFO - Reading from file tmpfile_stdout 10:31:07 INFO - Output received: 10:31:07 INFO - Usage: mozinstall [options] installer 10:31:07 INFO - Options: 10:31:07 INFO - -h, --help show this help message and exit 10:31:07 INFO - -d DEST, --destination=DEST 10:31:07 INFO - Directory to install application into. [default: 10:31:07 INFO - "/builds/slave/test"] 10:31:07 INFO - --app=APP Application being installed. [default: firefox] 10:31:07 INFO - mkdir: /builds/slave/test/build/application 10:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:31:20 INFO - Reading from file tmpfile_stdout 10:31:20 INFO - Output received: 10:31:20 INFO - /builds/slave/test/build/application/firefox/firefox 10:31:20 INFO - Running post-action listener: _resource_record_post_action 10:31:20 INFO - ##### 10:31:20 INFO - ##### Running run-tests step. 10:31:20 INFO - ##### 10:31:20 INFO - Running pre-action listener: _resource_record_pre_action 10:31:20 INFO - Running main action method: run_tests 10:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:31:20 INFO - Python 2.7.3 10:31:20 INFO - Return code: 0 10:31:20 INFO - grabbing minidump binary from tooltool 10:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8410>, '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 0x16c9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:31:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:31:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:31:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:31:20 INFO - Return code: 0 10:31:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:31:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:31:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:31:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:31:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:31:21 INFO - Return code: 0 10:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:31:21 INFO - Using env: {'DISPLAY': ':0', 10:31:21 INFO - 'HOME': '/home/cltbld', 10:31:21 INFO - 'LANG': 'en_US.UTF-8', 10:31:21 INFO - 'LANGUAGE': 'en_US:en', 10:31:21 INFO - 'LOGNAME': 'cltbld', 10:31:21 INFO - 'MAIL': '/var/mail/cltbld', 10:31:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:31:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:21 INFO - 'MOZ_NO_REMOTE': '1', 10:31:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:21 INFO - 'NO_EM_RESTART': '1', 10:31:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:21 INFO - 'PWD': '/builds/slave/test', 10:31:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:31:21 INFO - 'SHELL': '/bin/bash', 10:31:21 INFO - 'SHLVL': '1', 10:31:21 INFO - 'TERM': 'linux', 10:31:21 INFO - 'TMOUT': '86400', 10:31:21 INFO - 'USER': 'cltbld', 10:31:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879', 10:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:21 INFO - '_': '/tools/buildbot/bin/python'} 10:31:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:31:21 INFO - mozversion application_buildid: 20160706073423 10:31:21 INFO - mozversion application_changeset: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d 10:31:21 INFO - mozversion application_display_name: Firefox 10:31:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:31:21 INFO - mozversion application_name: Firefox 10:31:21 INFO - mozversion application_remotingname: firefox 10:31:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:31:21 INFO - mozversion application_vendor: Mozilla 10:31:21 INFO - mozversion application_version: 48.0 10:31:21 INFO - mozversion platform_buildid: 20160706073423 10:31:21 INFO - mozversion platform_changeset: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d 10:31:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:31:21 INFO - mozversion platform_version: 48.0 10:31:21 INFO - using testdate: 1467826281 10:31:21 INFO - actual date: 1467826281 10:31:21 INFO - starting webserver on 'localhost:51476' 10:31:21 INFO - SUITE-START | Running 2 tests 10:31:21 INFO - TEST-START | dromaeo_css 10:31:21 INFO - operating with platform_type : linux_ 10:31:21 INFO - Initialising browser for dromaeo_css test... 10:31:21 INFO - TEST-INFO | started process 24836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_WV1j/profile http://localhost:51476/getInfo.html) 10:31:25 INFO - PROCESS | 24836 | __metrics Screen width/height:1600/1200 10:31:25 INFO - PROCESS | 24836 | colorDepth:24 10:31:25 INFO - PROCESS | 24836 | Browser inner width/height: 1024/697 10:31:25 INFO - PROCESS | 24836 | __metrics 10:31:26 ERROR - PROCESS | 24836 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:31:27 INFO - TEST-INFO | 24836: exit 0 10:31:27 INFO - Browser initialized. 10:31:27 INFO - Running cycle 1/1 for dromaeo_css test... 10:31:27 INFO - TEST-INFO | started process 24927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_WV1j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:39 INFO - PROCESS | 24927 | RSS: Main: 139730944 10:31:39 INFO - PROCESS | 24927 | 10:32:30 INFO - PROCESS | 24927 | 1467826350049 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:34:37 INFO - PROCESS | 24927 | Cycle 1(1): loaded http://localhost:51476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51476/tests/dromaeo/cssquery-ext.html) 10:34:38 INFO - PROCESS | 24927 | RSS: Main: 251785216 10:34:38 INFO - PROCESS | 24927 | 10:37:40 INFO - PROCESS | 24927 | Cycle 1(1): loaded http://localhost:51476/tests/dromaeo/cssquery-ext.html (next: http://localhost:51476/tests/dromaeo/cssquery-jquery.html) 10:37:41 INFO - PROCESS | 24927 | RSS: Main: 229138432 10:37:41 INFO - PROCESS | 24927 | 10:40:42 INFO - PROCESS | 24927 | Cycle 1(1): loaded http://localhost:51476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51476/tests/dromaeo/cssquery-mootools.html) 10:40:43 INFO - PROCESS | 24927 | RSS: Main: 217878528 10:40:43 INFO - PROCESS | 24927 | 10:43:45 INFO - PROCESS | 24927 | Cycle 1(1): loaded http://localhost:51476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51476/tests/dromaeo/cssquery-prototype.html) 10:43:45 INFO - PROCESS | 24927 | RSS: Main: 222126080 10:43:45 INFO - PROCESS | 24927 | 10:46:48 INFO - PROCESS | 24927 | Cycle 1(1): loaded http://localhost:51476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51476/tests/dromaeo/cssquery-yui.html) 10:46:48 INFO - PROCESS | 24927 | RSS: Main: 209989632 10:46:48 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | Cycle 1(1): loaded http://localhost:51476/tests/dromaeo/cssquery-yui.html (next: http://localhost:51476/tests/dromaeo/cssquery-dojo.html) 10:49:51 INFO - PROCESS | 24927 | RSS: Main: 241430528 10:49:51 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | __start_tp_report 10:49:51 INFO - PROCESS | 24927 | _x_x_mozilla_page_load 10:49:51 INFO - PROCESS | 24927 | _x_x_mozilla_page_load_details 10:49:51 INFO - PROCESS | 24927 | |i|pagename|runs| 10:49:51 INFO - PROCESS | 24927 | |0;dojo.html;3208.1017315151757;3232.7898686585386;3240.2061494933746;3274.492453669681;3277.229850985018;5502.2296878437;5515.531179849712;5521.199426083215;5527.226188333637;5533.861653458665;5459.481349271823;5466.453354664542;5527.364353099395;5540.168974653794;5559.499645031946;4934.309196712463;5050.217216331474;5081.085404627165;5106.234064890277;5165.4834516548235;4872.293517439969;4942.382202224722;4965.478624744404;4984.700917944917;4987.127252730776;5031.6729412588065;5093.821716239932;5124.385073791151;5126.71803050832;5145.922811157836;5110.616703747234;5124.103281925685;5127.871803204913;5128.5640720538795;5132.204508301219;4826.227803551415;4931.43288521821;5001.974990125026;5009.674371165863;5040.621953353513;5273.182656688181;5295.338082739658;5308.097623404031;5322.361316642027;5329.866753331159;5844.444777746107;5850.3564607893095;5854.531637468992;5868.2664666916635;5871.442212989759;5848.473637372615;5894.145348924382;5922.082077278029;5948.553858460633;5984.311804142536;5460.153676180159;5467.0705979983495;5495.203195536665;5504.091824848935;5504.64219825714;5714.142878568248;5969.31352894414;5987.491063259672;5997.280326360865;5998.1602575639445;5759.913601295984;5818.738156782955;5828.213191219216;5834.912476312774;5845.678487683133;5729.255196824386;5738.483536481736;5763.6541807491685;5769.8557536061935;5771;5657;5679.858003549944;5708.115242137475;5723.971380143073;5727.856803579861;5850.268716410449;5858.326292476335;5861.9706901465215;5863.296404431496;5898.469137777621;4486.528914463999;4493.303537951622;4497.392851964943;4499.707519011319;4525.660575456854;3968.7420317679257;4004.819783109767;4011.4584531088512;4049.453323801308;4068.450759147477;5553.972230138905;5576.581756368289;5578.386377498472;5578.497935185853;5597.160425936142;5854.765809367577;5855;5889.793857214977;5895.823125306248;5899.911501327483;5395.676259424447;5510.228568000483;5525.143602741581;5594.916076258859;5596.524295434852;4970.850874473772;5011.123053465629;5015.14742493777;5016.197408414636;5053.873653158627;6119.938800611937;6134.6625935573975;6158.969205154035;6159.353267906895;6160.1375807387;5740.311162660424;5843.649381037151;5854.209681692917;5921.052631578927;5929.0513517836935;5992.340842507408;6022.247219097613;6027.909581356371;6031.879362412815;6032.547558933185;5623;5738.885222295614;5742.7702891883855;5752.654840709571;5756.1941328214925;5866.911996319973;5901.881962360814;5916.881662366643;5918.852028699317;5986.16193732869;5656.6888821115235;5662.546996240373;5680.2047713321;5685.658860468385;5691.544676425793;5564.777408903598;5680.204771331934;5689.459501347365;5692.117721753135;5717.142428635738;5552.916706249329;5564.10974244119;5567.832965011056;5585.664860108406;5602.52378547828;5654.7455364509515;5657.179708942263;5664.603477756517;5665.971670141623;5697.715114244188;5490.368607610176;5520.944790552043;5552.7778888843995;5584.246126772834;5636.774529018793 10:49:51 INFO - PROCESS | 24927 | |1;ext.html;639.7504973060508;662.8541720821418;665.6771465839064;677.4546490075489;739.6006156675395;32330.515042274354;32865.67134328656;40279;40973.180536389256;41369;43792.78103609478;44278.335824962654;44326;44390.33414498785;44422;7563.962180189092;8736.650533978633;8910.153535414125;8912.688055918044;10329.328593641389;10412.479376031206;10533.05202531772;10550.894491055067;10561.049505544499;10561.683149505527;10569.788604227911;10659.307145035587;10660.520276587533;10661.413622250773;10661.626843060494;10494.947525262402;10559.947200263949;10583.10043646291;10585;10590.523426445829;10314.896851031544;10728.678139655824;10739.677809665722;10757.085647719954;10768.623098191525;43284.56715432868;43784.343234851505;43864.561354386366;43883.12233755307;43905.34141987873;3912.1393293475676;4346.174226896879;4368.47578290604;4478.2386994211065;4685.0395668887795;33102;33992.83003584966;34172.14569635754;34702.13244668904;35344.46983295253;4575.107853968478;4579.381783459224;4608.23964045932;4615.653825963032;4642.489326174118;329098;329770;330592.9999999976;331278;333309;38530.22939541194;61207.693961529905;62041.68979155165;62121.689391552754;62156;37103.4434483483;37173;37235.441468378;37321.81339093287;37382.43926341107;16704.08127552972;16880.577985550215;16888.240029198714;16892.324307027826;16893.324267029428;13019.47922083125;14628.707425851424;15022.49775022511;15036.248187590576;15056.096634201984;8963;8987.281017518582;8991.41555798871;9012.549372531346;9045.77385565353;3492.284081763283;3512.5082488451635;3512.8946131616094;3516.1033936346066;3607.7294202934886;966.2704657983178;1141.2182654881433;1166.3293606176483;1204.325577676504;1251.2805137046234;33111.16103746954;33116.503252451235;33385.332293354;33661.326773464396;33836.154096147795;1141.5319718915205;1176.3236139219982;1226.7485165541043;1248.6254123762835;1252.9976019184617;16243.106629135274;16248.59378515523;16251.431199908184;16267.349306027863;16550.08974506414;514094;518361;519828;520518;521365;59284;59887.40112598818;59933.70033149806;59969.40030599725;60088.69955650194;1345.2399394342165;1486.9628608806006;1527.793747844027;1536.8924175307845;1599.4561848971405;30121.698783012765;30273.65707176391;32283.19292017718;32301.192470188435;33364.83317583396;50768.74615627046;51601.741991289804;51740.482595175075;51771.48228517817;51878.48121518888;359609;363078;365238;366241;366361;26007.219783406526;26338.07816726482;29396.853015734785;29423.85288073546;29983.850080749457;43620.505959017566;43811;44044.33933491064;44674.77662611666;44872.32691509565;37145.628543714214;37233;37534.43698344472;38909.41635875521;40548.59451405448;38277.23445531018;39906;40125.39811902765;40272.597274026884;40925;40179.461615154534;40188.79905600454;41587;41765;41898.79050604728;34221.82889085539;35305.47041794324;35445;36227;36289.45565816462;27681.72318276872;28048.43903121885;28128;28197;28290.43419131647 10:49:51 INFO - PROCESS | 24927 | |2;jquery.html;415.63631822155605;429.795846972688;433.2310149484666;434.71091724003537;443.436884980444;18442.446726598206;18972.241110355586;19061.237550497997;19293.421197364067;20145.697814532756;12188.268703877773;12438.875611243884;13202.933985330084;19583.706244406345;19596;5300.681959082467;5320.9467905321035;5457.590680698943;5487;5498.725063746817;5367;5392.272043274166;5409.513143817056;5418.972905135469;5437.211604317372;5411.540019098381;5420.349558053039;5420.430854760233;5426.21319908613;5426.21319908613;5192.636515443921;5457.645253058578;5461.590380721442;5462.180672899057;5463.235147079412;5297.655652382583;5311.389190243133;5317.9468205317835;5318.547923426513;5322.65402748824;18095.547611309823;22784.77215227843;23312.883435582884;23633.409164770845;23722.40693982647;2393.748656391089;2418.600930846408;2468.419921318489;2551.553478141318;2592.5981472871736;10290.794184116276;10643.201759868041;10809.297395669257;12208;14662.706745865024;1948.2012374926212;1988.602279544097;2000.3098930868828;2038.7247721557549;2053.4558342039372;59146;62658.68670656663;75949.62025189894;76428.23571764267;79423;10439.478026098664;10553.84169237462;10696.679099626868;10728.498010278567;10868.510917008754;15123.924380378028;15185.088894666356;15231.695366092616;15232;15244.923775381274;7713;8599.699010534601;8715.346349023848;8718.346124040723;8944.776380590538;8820.191860668547;8906.109389061043;8946.150115738994;9022.278217742565;9051.954740226256;4722.504137065627;4727.054589082198;4755.714657120584;4773.427188737304;4860.635452341088;1981.682930731076;2009.9899500502697;2026.1996511377922;2071.492484341346;2100.3488918435332;1007.3804610164696;1032.9276950613385;1075.6289080267295;1086.7283179205199;1158.0793269350886;18604.720929186074;18769.436916892515;18837.434876953714;19156.425307240806;19163.520911977314;1045.0803293102022;1078.735709751116;1143.0912424622445;1148.1618418554501;1189.3696340939316;10453.947730261452;10800.405977671146;10812.513436895359;10872.238943273895;10895.455227238765;470709;569113;584150;586032;596153;87955;90310;97063.51468242613;98006;98264.50867745615;1082.723905404117;1103.6082190822303;1134.3987686525988;1159.8492196014633;1169.6432588060723;16698.4155554555;17129.314827406764;17987.19057642383;17999.910000449912;18027.549311267325;40386.596134038286;41698.374524382765;41886.37170442385;42510.362344565474;42587.148257035304;55690;56722.43277567172;57117.42882571121;57144;57282.713586431804;8742.256908162622;8786.516741579275;8989.190972812217;9015.954920225357;9048.547572621212;9559.474228917476;12973.805392919303;13856.93071534636;14086.577402677936;14302.499412520512;11860.76278474443;12027.939860300643;12060.879391205975;12462.202594095459;12466.252024878537;11888.34614096233;12008.879911200776;12053.879461205275;12112.333821639895;12231.449584768528;12168.57409990646;12390.75218495607;12411.255324680547;12501.624951251477;12699.809502857279;8576.828463430822;8880.37837351405;9064.761781756191;9193.724188274362;9195.126462986005;10730.356178629307;11465.14011449128;11603.245789023686;11638.53445862156;11734.471948762497 10:49:51 INFO - PROCESS | 24927 | |3;mootools.html;1358.517726207197;1587.88090893183;1611.86299164571;1858.9349372771956;1914.9425517234479;8338.416310858234;8497.150284971514;8523.147685231474;8539.316854651628;8550.52972086535;8387.412881098326;8566.828663426742;8567.443116197443;8569.871451928226;8571.699990500334;2419.250032489925;2435.5007223519137;2435.866027368494;2441.414060625446;2442.9022839086415;2399.78401943825;2448.6204638281097;2469.444375015616;2473.567125752986;2481.2928315430104;2379.1078345620394;2419.8185136114776;2425.0663494554547;2430.987845060772;2434.6469761884514;2366.9053237870635;2412.2883749294;2417.7703118203744;2423.7455067217866;2429.5626787178303;2413.1433341163984;2455.4475243070347;2474.0969546115716;2474.307193985687;2478.6901637295337;6964.164300283998;8203.384746144004;8671.13288671134;8716.520591367473;8723.60743766532;5269.130593452076;5455.481729235756;5457.536109430703;5458.863528411782;5466.617336786427;3566.8394922228563;3578.2127931854952;3639.581448133472;3756.3426400379826;3798.392257238856;1137.056243318044;1138.7210133517342;1157.0107558037926;1174.9530018799237;1178.917475776696;12428.316442595744;12434.875651243552;12527.686807829787;12528.937355313165;12540.561080362144;4668.906621867543;4733.573978341966;4764.809407623726;4771.73755443447;4804.591609713144;10466.63366782159;10470.947645261876;10480;10480.790384192425;10492.685219443429;5322.92015619766;5324.254604355393;5346.037713211659;5350.956563470086;5357.651752636066;4803.903921921612;4818.469968303554;4818.951810481921;4820.30105634681;4822.517748225149;3799.50606421169;3990.1421194443333;4000.3799411091327;4002.3596224603925;4041.2523683118716;1309.4434865182259;1311.4819646239873;1311.6065180445828;1325.9602211933657;1332.9466821327233;1007.7531004903846;1038.3925403638955;1056.2131212246925;1068.6687126990657;1074.4520294649628;5993.0710739835395;6003.189569408161;6029.547783916136;6057.121717350959;6310.432061114522;455.7425054844002;459.9310103484437;469.9365585645962;474.02351156617476;480.74280260061397;4203.47456567929;4214.726042807208;4240.554741752133;4272.33778764292;4327.199468098412;10203.94898025505;10571.312864663925;10645.84031239532;10653.627123050655;10665.626703065356;10471.581136754445;10485.37087774736;10486.842697359545;10506.527206275736;10510.264281500222;7941.285284324438;8104.797380065545;8209.014918209854;8214.219649133323;8223.301019413297;6051.304100028553;6051.848703782441;6109.7861574844665;6128.9693551531955;6226.62640241587;9249.12133347331;9333.533323333942;9401.482918439551;9436.858447123435;9511.904880951379;9192.667063275654;9657.806843863224;9677.177439917687;9860.26048046385;9965.701028969142;7733.188015258317;7771.37828973692;7811.804704882424;7818.179091195342;7845.097813751491;8347.874781878156;8449.155084491502;8474.449160804528;8478.57607119654;8501.362397820065;7211.8557628848175;7296.854062918605;7384.556926584422;7435.442341824493;7510.061242344707;7413.2957369049855;7431.554106753612;7449.515781474187;7544.47188696786;7589.051368578927;6809.965950170217;6857.55425897315;6919.100516932968;6921.8961715575315;6941.861162776615;4536.637069034536;5301.151815709468;5389.946100538945;5397.352317721741;5461.754221059982;5174.741262936914;5200.479952004921;5219.8434046978655;5322.802369466839;5343.438938911514 10:49:51 INFO - PROCESS | 24927 | |4;prototype.html;326.84311530465374;352.83769466045624;354.6063869105294;354.8030842882199;356.1239351196058;6130.11113388559;6156.938430615693;6191.783287584935;6307.274663413708;6318.652474113922;6133.938660613392;6141.754329826813;6189.442950134487;6191.690415479219;6230.470410015143;4691.554302341272;4694.788734506938;4694.882627934312;4697.084068606623;4698.530146985291;4486.102779444108;4570.291604801261;4639.814407423699;4688.179568575502;4722.598579120779;4653.4881163072205;4665.603423708972;4668.18306796311;4670.252759558472;4679.461861885876;4437.179121862466;4660.324252983315;4660.580547750685;4661.813527458931;4662.953370466286;3976.0258736609426;4026.879193624196;4047.3928910663635;4055.5944405559503;4057;5821.476067153934;5825.213596164506;5897.8820423591715;5917.644941303535;5918.053111502182;5390.6226564140525;5420.945790542123;5430.294061771984;5435.483629055233;5438.401775804658;6483.384078512534;6484.124643173205;6485.156929599122;6487;6496.805095847132;4535.229011068126;4537.0925814837165;4539.863804085882;4544.909101817978;4550.249208880531;6602.86794264112;6805.455563554904;6806.6256355900905;6817.250102488672;6817.931820681779;4583;4630.143423466669;4630.259158534685;4641.698289611165;4646.233371493666;4702.600278976325;4705.411823522059;4706.1999460091865;4708.741019243906;4711.929321060187;5416.593755468356;5422.864428389243;5446.101393270066;5448.56411487088;5456.836294911159;6555.082288479522;6560.3111673273615;6565.441937435276;6569.934300657028;6573.934260657332;1570.1050401271166;1639.6392793585392;1640.4176517336412;1640.958976025609;1641.4747280870006;1045.0646671229208;1046.6912260883057;1054.799588078278;1055.1400608504046;1059.750958524746;6099.969500152471;6209.06863970399;6233.3143354231;6278.215223097113;6378;6770;6775.864482710318;6779.49153813466;6829.317068293131;6832.863342733217;6347.619142851351;6356.713947872357;6359.268684101295;6360.459360954371;6368.267649220306;3597.6941959933697;3633.9818300908855;3638.4360424133774;3640.4903313536124;3641.5448068991377;6923.5499692519825;7052.92947070533;7075.752348667875;7077.92922070783;7080.575165489984;6852.143482064742;6871.553349032297;6881.483888708367;6886.035954966309;6890.586564806128;7074.540154889915;7076.32774886385;7095.964520177469;7104.502684812013;7106.467014973898;6741.730330786713;6742.595444273359;6744.662766861539;6747.089142965637;6754.3921047106;6547.443467305332;6653.833654158685;6679.56582822115;6679.799606011828;6696.464282857457;7046.823829404306;7095.467839911924;7095.503314767917;7098;7104.467164962545;4564.42944631921;4569.862904112882;4576.130535198302;4578.839740609063;4580.267157254823;6678.966605166943;6687.297833727584;6689.896167132369;6690.83272918181;6694.966525167343;6514.706838192198;6531.836704082246;6552.08270842092;6566.474682025331;6573.079768832463;6347.968260158855;6582.473402127723;6586.637734924433;6592.637404942774;6595.175603049619;6415.486761059011;6462.642845002602;6478.481721462366;6479.773207937699;6485.383888530582;6578.736850525926;6614.6361950093205;6616.867662646817;6618.768343107968;6626.105475760711;6445.774397896051;6449.226092868886;6456.741730330734;6460.289368169591;6463.482921366373 10:49:51 INFO - PROCESS | 24927 | |5;yui.html;825.8018075661839;875.6541166239335;891.2424439226662;919.976052684095;926.6247169896192;15177.620559486018;15334;15343.769843452343;15370.077795332274;15386.076835389857;13937.790933136012;14044.087134336261;14072.366743496541;14094.647633809134;14110.929445352784;749.2395218852841;901.8286525560155;910.8269428808521;915.3866909170838;922.5894476957723;922.7231830450871;926.4626516620377;927.1099744245532;927.4249965021696;931.3899395895666;968.1238479176357;968.3608818180003;968.5351031504882;968.7142293023575;969.1616751509964;766.8811334243173;960.4477425480306;963.032152686549;964.0841200859177;980.294188184506;713.2190251674408;714.696254092014;716.2765606737233;716.6989864257024;716.7813816785879;14525.346359413852;14581.48964786238;14592.781108283385;14593.708125837424;14596.781048284285;13593.524226652118;14196.858031419657;14208.857911420857;14472.059316144418;14606.415743370253;11846.407679616072;12006.759864802654;12177.147599668027;12194.81707774384;12531.436085376088;4014.197160567898;4039.071013666873;4050.858219962287;4073.816678249486;4157.168566286755;55332.72333638346;55671;56735.71632141854;57342.7132864333;58200.70899645517;12039.097067719957;12044.156909016285;12172.452239649238;12180.695482612828;12240.44917978693;22003.33989980303;22139;22154.667679984814;22193.001314940866;22217;8850.34909434241;8952.060033696498;8999.10008999108;9131.406458580172;9351.579178936965;4910.238912968495;5014.89970200594;5056.974715126401;5057.519535644108;5074.06129865976;3631.1829838286176;3732.9626703732615;3736.514253147128;3743.419769935664;3745.8127093645207;701.8876979683329;705.9188193357727;721.2607077745353;723.8479919217024;725.9128904531384;742.7363286033489;742.7660287009575;757.7499425189784;762.0017776712524;778.1207235823483;9633.90366096344;9844.80310393788;10144.92753623189;10201.236301489635;10465.633702820365;701.3652644356865;828.3869936247133;829.1128492512953;849.9745007649657;851.1871163039283;4555.817767289272;4609.943131155028;4656.138614356355;4708.223143181405;4735.337052812609;67208.6639566799;67448;67557.98663020058;67585.32414675888;67741;54993;55582.16626750602;56292;56365;56615;52496.21255681244;52577.474225258025;52981.47018529842;53516.73241633767;54432;10206.23453240995;10209.897901020895;10248.077673009466;10443.582256709646;10478.37129772216;39495.407568885916;39533.604663952996;39703.40444893387;40579.59420405876;41390.1721965565;46664.30003550017;47225;51516;52712;53464;12917.28954907489;12946.935265323613;12984.480620775063;13105.80886945659;13294.268815215257;13207.867921320663;13535.458581656623;13798;14019.789703154256;14787.260636968324;13465.798013029616;13646.727065458834;13726.176429414267;13946.58160255194;14425.42298308056;12884.871151288367;13115.803262950873;13161.144525605805;13391.464341426623;14202.857971420153;13647.931760341135;13678.93160534191;13734.45062197541;13827.86172138306;13895.722085558435;11276.887231127585;11369.488373023069;11449.370284634426;11560.13299002595;11676.474558644712;11312.60405885823;11333.943330283295;11614.6515604532;11680.707982300171;11792.52829886795 10:49:51 INFO - PROCESS | 24927 | __end_tp_report 10:49:51 INFO - PROCESS | 24927 | __start_cc_report 10:49:51 INFO - PROCESS | 24927 | _x_x_mozilla_cycle_collect,837 10:49:51 INFO - PROCESS | 24927 | __end_cc_report 10:49:51 INFO - PROCESS | 24927 | __startTimestamp1467827391474__endTimestamp 10:49:51 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | ------- Summary: start ------- 10:49:51 INFO - PROCESS | 24927 | Number of tests: 6 10:49:51 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | [#0] dojo.html Cycles:165 Average:5437.93 Median:5596.52 stddev:596.43 (10.7%) stddev-sans-first:572.03 10:49:51 INFO - PROCESS | 24927 | Values: 3208.1 3232.8 3240.2 3274.5 3277.2 5502.2 5515.5 5521.2 5527.2 5533.9 5459.5 5466.5 5527.4 5540.2 5559.5 4934.3 5050.2 5081.1 5106.2 5165.5 4872.3 4942.4 4965.5 4984.7 4987.1 5031.7 5093.8 5124.4 5126.7 5145.9 5110.6 5124.1 5127.9 5128.6 5132.2 4826.2 4931.4 5002.0 5009.7 5040.6 5273.2 5295.3 5308.1 5322.4 5329.9 5844.4 5850.4 5854.5 5868.3 5871.4 5848.5 5894.1 5922.1 5948.6 5984.3 5460.2 5467.1 5495.2 5504.1 5504.6 5714.1 5969.3 5987.5 5997.3 5998.2 5759.9 5818.7 5828.2 5834.9 5845.7 5729.3 5738.5 5763.7 5769.9 5771.0 5657.0 5679.9 5708.1 5724.0 5727.9 5850.3 5858.3 5862.0 5863.3 5898.5 4486.5 4493.3 4497.4 4499.7 4525.7 3968.7 4004.8 4011.5 4049.5 4068.5 5554.0 5576.6 5578.4 5578.5 5597.2 5854.8 5855.0 5889.8 5895.8 5899.9 5395.7 5510.2 5525.1 5594.9 5596.5 4970.9 5011.1 5015.1 5016.2 5053.9 6119.9 6134.7 6159.0 6159.4 6160.1 5740.3 5843.6 5854.2 5921.1 5929.1 5992.3 6022.2 6027.9 6031.9 6032.5 5623.0 5738.9 5742.8 5752.7 5756.2 5866.9 5901.9 5916.9 5918.9 5986.2 5656.7 5662.5 5680.2 5685.7 5691.5 5564.8 5680.2 5689.5 5692.1 5717.1 5552.9 5564.1 5567.8 5585.7 5602.5 5654.7 5657.2 5664.6 5666.0 5697.7 5490.4 5520.9 5552.8 5584.2 5636.8 10:49:51 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | [#1] ext.html Cycles:180 Average:56244.77 Median:19917.36 stddev:109326.35 (548.9%) stddev-sans-first:109553.32 10:49:51 INFO - PROCESS | 24927 | Values: 639.8 662.9 665.7 677.5 739.6 32330.5 32865.7 40279.0 40973.2 41369.0 43792.8 44278.3 44326.0 44390.3 44422.0 7564.0 8736.7 8910.2 8912.7 10329.3 10412.5 10533.1 10550.9 10561.0 10561.7 10569.8 10659.3 10660.5 10661.4 10661.6 10494.9 10559.9 10583.1 10585.0 10590.5 10314.9 10728.7 10739.7 10757.1 10768.6 43284.6 43784.3 43864.6 43883.1 43905.3 3912.1 4346.2 4368.5 4478.2 4685.0 33102.0 33992.8 34172.1 34702.1 35344.5 4575.1 4579.4 4608.2 4615.7 4642.5 329098.0 329770.0 330593.0 331278.0 333309.0 38530.2 61207.7 62041.7 62121.7 62156.0 37103.4 37173.0 37235.4 37321.8 37382.4 16704.1 16880.6 16888.2 16892.3 16893.3 13019.5 14628.7 15022.5 15036.2 15056.1 8963.0 8987.3 8991.4 9012.5 9045.8 3492.3 3512.5 3512.9 3516.1 3607.7 966.3 1141.2 1166.3 1204.3 1251.3 33111.2 33116.5 33385.3 33661.3 33836.2 1141.5 1176.3 1226.7 1248.6 1253.0 16243.1 16248.6 16251.4 16267.3 16550.1 514094.0 518361.0 519828.0 520518.0 521365.0 59284.0 59887.4 59933.7 59969.4 60088.7 1345.2 1487.0 1527.8 1536.9 1599.5 30121.7 30273.7 32283.2 32301.2 33364.8 50768.7 51601.7 51740.5 51771.5 51878.5 359609.0 363078.0 365238.0 366241.0 366361.0 26007.2 26338.1 29396.9 29423.9 29983.9 43620.5 43811.0 44044.3 44674.8 44872.3 37145.6 37233.0 37534.4 38909.4 40548.6 38277.2 39906.0 40125.4 40272.6 40925.0 40179.5 40188.8 41587.0 41765.0 41898.8 34221.8 35305.5 35445.0 36227.0 36289.5 27681.7 28048.4 28128.0 28197.0 28290.4 10:49:51 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | [#2] jquery.html Cycles:180 Average:30695.95 Median:23048.83 stddev:92419.06 (401.0%) stddev-sans-first:92650.35 10:49:51 INFO - PROCESS | 24927 | Values: 415.6 429.8 433.2 434.7 443.4 18442.4 18972.2 19061.2 19293.4 20145.7 12188.3 12438.9 13202.9 19583.7 19596.0 5300.7 5320.9 5457.6 5487.0 5498.7 5367.0 5392.3 5409.5 5419.0 5437.2 5411.5 5420.3 5420.4 5426.2 5426.2 5192.6 5457.6 5461.6 5462.2 5463.2 5297.7 5311.4 5317.9 5318.5 5322.7 18095.5 22784.8 23312.9 23633.4 23722.4 2393.7 2418.6 2468.4 2551.6 2592.6 10290.8 10643.2 10809.3 12208.0 14662.7 1948.2 1988.6 2000.3 2038.7 2053.5 59146.0 62658.7 75949.6 76428.2 79423.0 10439.5 10553.8 10696.7 10728.5 10868.5 15123.9 15185.1 15231.7 15232.0 15244.9 7713.0 8599.7 8715.3 8718.3 8944.8 8820.2 8906.1 8946.2 9022.3 9052.0 4722.5 4727.1 4755.7 4773.4 4860.6 1981.7 2010.0 2026.2 2071.5 2100.3 1007.4 1032.9 1075.6 1086.7 1158.1 18604.7 18769.4 18837.4 19156.4 19163.5 1045.1 1078.7 1143.1 1148.2 1189.4 10453.9 10800.4 10812.5 10872.2 10895.5 470709.0 569113.0 584150.0 586032.0 596153.0 87955.0 90310.0 97063.5 98006.0 98264.5 1082.7 1103.6 1134.4 1159.8 1169.6 16698.4 17129.3 17987.2 17999.9 18027.5 40386.6 41698.4 41886.4 42510.4 42587.1 55690.0 56722.4 57117.4 57144.0 57282.7 8742.3 8786.5 8989.2 9016.0 9048.5 9559.5 12973.8 13856.9 14086.6 14302.5 11860.8 12027.9 12060.9 12462.2 12466.3 11888.3 12008.9 12053.9 12112.3 12231.4 12168.6 12390.8 12411.3 12501.6 12699.8 8576.8 8880.4 9064.8 9193.7 9195.1 10730.4 11465.1 11603.2 11638.5 11734.5 10:49:51 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | [#3] mootools.html Cycles:180 Average:5755.16 Median:4804.25 stddev:3186.05 (66.3%) stddev-sans-first:3177.85 10:49:51 INFO - PROCESS | 24927 | Values: 1358.5 1587.9 1611.9 1858.9 1914.9 8338.4 8497.2 8523.1 8539.3 8550.5 8387.4 8566.8 8567.4 8569.9 8571.7 2419.3 2435.5 2435.9 2441.4 2442.9 2399.8 2448.6 2469.4 2473.6 2481.3 2379.1 2419.8 2425.1 2431.0 2434.6 2366.9 2412.3 2417.8 2423.7 2429.6 2413.1 2455.4 2474.1 2474.3 2478.7 6964.2 8203.4 8671.1 8716.5 8723.6 5269.1 5455.5 5457.5 5458.9 5466.6 3566.8 3578.2 3639.6 3756.3 3798.4 1137.1 1138.7 1157.0 1175.0 1178.9 12428.3 12434.9 12527.7 12528.9 12540.6 4668.9 4733.6 4764.8 4771.7 4804.6 10466.6 10470.9 10480.0 10480.8 10492.7 5322.9 5324.3 5346.0 5351.0 5357.7 4803.9 4818.5 4819.0 4820.3 4822.5 3799.5 3990.1 4000.4 4002.4 4041.3 1309.4 1311.5 1311.6 1326.0 1332.9 1007.8 1038.4 1056.2 1068.7 1074.5 5993.1 6003.2 6029.5 6057.1 6310.4 455.7 459.9 469.9 474.0 480.7 4203.5 4214.7 4240.6 4272.3 4327.2 10203.9 10571.3 10645.8 10653.6 10665.6 10471.6 10485.4 10486.8 10506.5 10510.3 7941.3 8104.8 8209.0 8214.2 8223.3 6051.3 6051.8 6109.8 6129.0 6226.6 9249.1 9333.5 9401.5 9436.9 9511.9 9192.7 9657.8 9677.2 9860.3 9965.7 7733.2 7771.4 7811.8 7818.2 7845.1 8347.9 8449.2 8474.4 8478.6 8501.4 7211.9 7296.9 7384.6 7435.4 7510.1 7413.3 7431.6 7449.5 7544.5 7589.1 6810.0 6857.6 6919.1 6921.9 6941.9 4536.6 5301.2 5389.9 5397.4 5461.8 5174.7 5200.5 5219.8 5322.8 5343.4 10:49:51 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | [#4] prototype.html Cycles:180 Average:5469.36 Median:6255.76 stddev:1669.25 (26.7%) stddev-sans-first:1628.69 10:49:51 INFO - PROCESS | 24927 | Values: 326.8 352.8 354.6 354.8 356.1 6130.1 6156.9 6191.8 6307.3 6318.7 6133.9 6141.8 6189.4 6191.7 6230.5 4691.6 4694.8 4694.9 4697.1 4698.5 4486.1 4570.3 4639.8 4688.2 4722.6 4653.5 4665.6 4668.2 4670.3 4679.5 4437.2 4660.3 4660.6 4661.8 4663.0 3976.0 4026.9 4047.4 4055.6 4057.0 5821.5 5825.2 5897.9 5917.6 5918.1 5390.6 5420.9 5430.3 5435.5 5438.4 6483.4 6484.1 6485.2 6487.0 6496.8 4535.2 4537.1 4539.9 4544.9 4550.2 6602.9 6805.5 6806.6 6817.3 6817.9 4583.0 4630.1 4630.3 4641.7 4646.2 4702.6 4705.4 4706.2 4708.7 4711.9 5416.6 5422.9 5446.1 5448.6 5456.8 6555.1 6560.3 6565.4 6569.9 6573.9 1570.1 1639.6 1640.4 1641.0 1641.5 1045.1 1046.7 1054.8 1055.1 1059.8 6100.0 6209.1 6233.3 6278.2 6378.0 6770.0 6775.9 6779.5 6829.3 6832.9 6347.6 6356.7 6359.3 6360.5 6368.3 3597.7 3634.0 3638.4 3640.5 3641.5 6923.5 7052.9 7075.8 7077.9 7080.6 6852.1 6871.6 6881.5 6886.0 6890.6 7074.5 7076.3 7096.0 7104.5 7106.5 6741.7 6742.6 6744.7 6747.1 6754.4 6547.4 6653.8 6679.6 6679.8 6696.5 7046.8 7095.5 7095.5 7098.0 7104.5 4564.4 4569.9 4576.1 4578.8 4580.3 6679.0 6687.3 6689.9 6690.8 6695.0 6514.7 6531.8 6552.1 6566.5 6573.1 6348.0 6582.5 6586.6 6592.6 6595.2 6415.5 6462.6 6478.5 6479.8 6485.4 6578.7 6614.6 6616.9 6618.8 6626.1 6445.8 6449.2 6456.7 6460.3 6463.5 10:49:51 INFO - PROCESS | 24927 | 10:49:51 INFO - PROCESS | 24927 | [#5] yui.html Cycles:180 Average:15937.62 Median:22731.99 stddev:18256.75 (80.3%) stddev-sans-first:18272.70 10:49:51 INFO - PROCESS | 24927 | Values: 825.8 875.7 891.2 920.0 926.6 15177.6 15334.0 15343.8 15370.1 15386.1 13937.8 14044.1 14072.4 14094.6 14110.9 749.2 901.8 910.8 915.4 922.6 922.7 926.5 927.1 927.4 931.4 968.1 968.4 968.5 968.7 969.2 766.9 960.4 963.0 964.1 980.3 713.2 714.7 716.3 716.7 716.8 14525.3 14581.5 14592.8 14593.7 14596.8 13593.5 14196.9 14208.9 14472.1 14606.4 11846.4 12006.8 12177.1 12194.8 12531.4 4014.2 4039.1 4050.9 4073.8 4157.2 55332.7 55671.0 56735.7 57342.7 58200.7 12039.1 12044.2 12172.5 12180.7 12240.4 22003.3 22139.0 22154.7 22193.0 22217.0 8850.3 8952.1 8999.1 9131.4 9351.6 4910.2 5014.9 5057.0 5057.5 5074.1 3631.2 3733.0 3736.5 3743.4 3745.8 701.9 705.9 721.3 723.8 725.9 742.7 742.8 757.7 762.0 778.1 9633.9 9844.8 10144.9 10201.2 10465.6 701.4 828.4 829.1 850.0 851.2 4555.8 4609.9 4656.1 4708.2 4735.3 67208.7 67448.0 67558.0 67585.3 67741.0 54993.0 55582.2 56292.0 56365.0 56615.0 52496.2 52577.5 52981.5 53516.7 54432.0 10206.2 10209.9 10248.1 10443.6 10478.4 39495.4 39533.6 39703.4 40579.6 41390.2 46664.3 47225.0 51516.0 52712.0 53464.0 12917.3 12946.9 12984.5 13105.8 13294.3 13207.9 13535.5 13798.0 14019.8 14787.3 13465.8 13646.7 13726.2 13946.6 14425.4 12884.9 13115.8 13161.1 13391.5 14202.9 13647.9 13678.9 13734.5 13827.9 13895.7 11276.9 11369.5 11449.4 11560.1 11676.5 11312.6 11333.9 11614.7 11680.7 11792.5 10:49:51 INFO - PROCESS | 24927 | -------- Summary: end -------- 10:49:51 INFO - PROCESS | 24927 | 10:49:52 INFO - TEST-INFO | 24927: exit 0 10:49:52 INFO - TEST-OK | dromaeo_css | took 1110391ms 10:49:52 INFO - TEST-START | kraken 10:49:52 INFO - operating with platform_type : linux_ 10:49:52 INFO - Initialising browser for kraken test... 10:49:52 INFO - TEST-INFO | started process 25120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLCrM9h/profile http://localhost:51476/getInfo.html) 10:49:56 INFO - PROCESS | 25120 | __metrics Screen width/height:1600/1200 10:49:56 INFO - PROCESS | 25120 | colorDepth:24 10:49:56 INFO - PROCESS | 25120 | Browser inner width/height: 1024/697 10:49:56 INFO - PROCESS | 25120 | __metrics 10:49:57 ERROR - PROCESS | 25120 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:49:57 INFO - TEST-INFO | 25120: exit 0 10:49:57 INFO - Browser initialized. 10:49:57 INFO - Running cycle 1/1 for kraken test... 10:49:57 INFO - TEST-INFO | started process 25211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLCrM9h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:09 INFO - PROCESS | 25211 | RSS: Main: 139776000 10:50:09 INFO - PROCESS | 25211 | 10:50:12 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51476/tests/kraken/driver.html?testName=audio-beat-detection) 10:50:12 INFO - PROCESS | 25211 | RSS: Main: 197521408 10:50:12 INFO - PROCESS | 25211 | 10:50:15 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51476/tests/kraken/driver.html?testName=audio-dft) 10:50:16 INFO - PROCESS | 25211 | RSS: Main: 184315904 10:50:16 INFO - PROCESS | 25211 | 10:50:18 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51476/tests/kraken/driver.html?testName=audio-fft) 10:50:19 INFO - PROCESS | 25211 | RSS: Main: 273833984 10:50:19 INFO - PROCESS | 25211 | 10:50:21 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51476/tests/kraken/driver.html?testName=audio-oscillator) 10:50:22 INFO - PROCESS | 25211 | RSS: Main: 179818496 10:50:22 INFO - PROCESS | 25211 | 10:50:24 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:50:24 INFO - PROCESS | 25211 | RSS: Main: 178098176 10:50:24 INFO - PROCESS | 25211 | 10:50:27 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51476/tests/kraken/driver.html?testName=imaging-darkroom) 10:50:28 INFO - PROCESS | 25211 | RSS: Main: 212615168 10:50:28 INFO - PROCESS | 25211 | 10:50:31 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51476/tests/kraken/driver.html?testName=imaging-desaturate) 10:50:32 INFO - PROCESS | 25211 | RSS: Main: 212434944 10:50:32 INFO - PROCESS | 25211 | 10:50:35 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51476/tests/kraken/driver.html?testName=json-parse-financial) 10:50:35 INFO - PROCESS | 25211 | RSS: Main: 212475904 10:50:35 INFO - PROCESS | 25211 | 10:50:37 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:50:37 INFO - PROCESS | 25211 | RSS: Main: 196440064 10:50:37 INFO - PROCESS | 25211 | 10:50:39 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51476/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:50:40 INFO - PROCESS | 25211 | RSS: Main: 199401472 10:50:40 INFO - PROCESS | 25211 | 10:50:42 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:50:42 INFO - PROCESS | 25211 | RSS: Main: 209735680 10:50:42 INFO - PROCESS | 25211 | 10:50:45 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:50:45 INFO - PROCESS | 25211 | RSS: Main: 217997312 10:50:45 INFO - PROCESS | 25211 | 10:50:48 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:50:49 INFO - PROCESS | 25211 | RSS: Main: 214507520 10:50:49 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:51476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51476/tests/kraken/driver.html?testName=ai-astar) 10:50:50 INFO - PROCESS | 25211 | RSS: Main: 274907136 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | __start_tp_report 10:50:50 INFO - PROCESS | 25211 | _x_x_mozilla_page_load 10:50:50 INFO - PROCESS | 25211 | _x_x_mozilla_page_load_details 10:50:50 INFO - PROCESS | 25211 | |i|pagename|runs| 10:50:50 INFO - PROCESS | 25211 | |0;ai-astar;110;112;112;112;111;112;106;109;111;109 10:50:50 INFO - PROCESS | 25211 | |1;audio-beat-detection;157;126;154;172;128;163;161;126;183;130 10:50:50 INFO - PROCESS | 25211 | |2;audio-dft;160;162;161;163;161;162;162;160;160;160 10:50:50 INFO - PROCESS | 25211 | |3;audio-fft;77;75;76;174;76;77;72;75;164;73 10:50:50 INFO - PROCESS | 25211 | |4;audio-oscillator;92;95;157;91;91;92;146;91;91;141 10:50:50 INFO - PROCESS | 25211 | |5;imaging-gaussian-blur;116;117;116;116;117;116;117;117;116;117 10:50:50 INFO - PROCESS | 25211 | |6;imaging-darkroom;145;145;146;145;145;146;146;146;145;146 10:50:50 INFO - PROCESS | 25211 | |7;imaging-desaturate;95;94;95;95;94;94;94;95;94;95 10:50:50 INFO - PROCESS | 25211 | |8;json-parse-financial;54;55;52;53;53;53;54;71;50;53 10:50:50 INFO - PROCESS | 25211 | |9;json-stringify-tinderbox;58;58;59;58;57;58;58;58;58;58 10:50:50 INFO - PROCESS | 25211 | |10;stanford-crypto-aes;73;76;72;73;73;72;73;72;72;73 10:50:50 INFO - PROCESS | 25211 | |11;stanford-crypto-ccm;116;119;112;113;121;127;115;122;130;114 10:50:50 INFO - PROCESS | 25211 | |12;stanford-crypto-pbkdf2;166;158;163;158;159;161;160;158;163;163 10:50:50 INFO - PROCESS | 25211 | |13;stanford-crypto-sha256-iterative;66;66;67;66;65;66;67;65;65;75 10:50:50 INFO - PROCESS | 25211 | __end_tp_report 10:50:50 INFO - PROCESS | 25211 | __start_cc_report 10:50:50 INFO - PROCESS | 25211 | _x_x_mozilla_cycle_collect,1568 10:50:50 INFO - PROCESS | 25211 | __end_cc_report 10:50:50 INFO - PROCESS | 25211 | __startTimestamp1467827450978__endTimestamp 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | ------- Summary: start ------- 10:50:50 INFO - PROCESS | 25211 | Number of tests: 14 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:1.96 (1.8%) stddev-sans-first:2.07 10:50:50 INFO - PROCESS | 25211 | Values: 110.0 112.0 112.0 112.0 111.0 112.0 106.0 109.0 111.0 109.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:159.00 stddev:20.99 (13.2%) stddev-sans-first:22.11 10:50:50 INFO - PROCESS | 25211 | Values: 157.0 126.0 154.0 172.0 128.0 163.0 161.0 126.0 183.0 130.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 10:50:50 INFO - PROCESS | 25211 | Values: 160.0 162.0 161.0 163.0 161.0 162.0 162.0 160.0 160.0 160.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.50 stddev:39.68 (52.6%) stddev-sans-first:41.62 10:50:50 INFO - PROCESS | 25211 | Values: 77.0 75.0 76.0 174.0 76.0 77.0 72.0 75.0 164.0 73.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:91.00 stddev:27.42 (30.1%) stddev-sans-first:28.41 10:50:50 INFO - PROCESS | 25211 | Values: 92.0 95.0 157.0 91.0 91.0 92.0 146.0 91.0 91.0 141.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:50:50 INFO - PROCESS | 25211 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:50:50 INFO - PROCESS | 25211 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:50:50 INFO - PROCESS | 25211 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:53.50 stddev:5.85 (10.9%) stddev-sans-first:6.19 10:50:50 INFO - PROCESS | 25211 | Values: 54.0 55.0 52.0 53.0 53.0 53.0 54.0 71.0 50.0 53.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 10:50:50 INFO - PROCESS | 25211 | Values: 58.0 58.0 59.0 58.0 57.0 58.0 58.0 58.0 58.0 58.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.20 (1.6%) stddev-sans-first:1.27 10:50:50 INFO - PROCESS | 25211 | Values: 73.0 76.0 72.0 73.0 73.0 72.0 73.0 72.0 72.0 73.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:120.00 stddev:6.08 (5.1%) stddev-sans-first:6.36 10:50:50 INFO - PROCESS | 25211 | Values: 116.0 119.0 112.0 113.0 121.0 127.0 115.0 122.0 130.0 114.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.00 stddev:2.77 (1.7%) stddev-sans-first:2.24 10:50:50 INFO - PROCESS | 25211 | Values: 166.0 158.0 163.0 158.0 159.0 161.0 160.0 158.0 163.0 163.0 10:50:50 INFO - PROCESS | 25211 | 10:50:50 INFO - PROCESS | 25211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.00 stddev:2.97 (4.5%) stddev-sans-first:3.14 10:50:50 INFO - PROCESS | 25211 | Values: 66.0 66.0 67.0 66.0 65.0 66.0 67.0 65.0 65.0 75.0 10:50:50 INFO - PROCESS | 25211 | -------- Summary: end -------- 10:50:50 INFO - PROCESS | 25211 | 10:50:52 INFO - TEST-INFO | 25211: exit 0 10:50:52 INFO - TEST-OK | kraken | took 59948ms 10:50:52 INFO - SUITE-END | took 1170s 10:50:52 INFO - Completed test suite (00:19:30) 10:50:52 INFO - javascript benchmark 10:50:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.1017315151757, 3232.7898686585386, 3240.2061494933746, 3274.492453669681, 3277.229850985018, 5502.2296878437, 5515.531179849712, 5521.199426083215, 5527.226188333637, 5533.861653458665, 5459.481349271823, 5466.453354664542, 5527.364353099395, 5540.168974653794, 5559.499645031946, 4934.309196712463, 5050.217216331474, 5081.085404627165, 5106.234064890277, 5165.4834516548235, 4872.293517439969, 4942.382202224722, 4965.478624744404, 4984.700917944917, 4987.127252730776, 5031.6729412588065, 5093.821716239932, 5124.385073791151, 5126.71803050832, 5145.922811157836, 5110.616703747234, 5124.103281925685, 5127.871803204913, 5128.5640720538795, 5132.204508301219, 4826.227803551415, 4931.43288521821, 5001.974990125026, 5009.674371165863, 5040.621953353513, 5273.182656688181, 5295.338082739658, 5308.097623404031, 5322.361316642027, 5329.866753331159, 5844.444777746107, 5850.3564607893095, 5854.531637468992, 5868.2664666916635, 5871.442212989759, 5848.473637372615, 5894.145348924382, 5922.082077278029, 5948.553858460633, 5984.311804142536, 5460.153676180159, 5467.0705979983495, 5495.203195536665, 5504.091824848935, 5504.64219825714, 5714.142878568248, 5969.31352894414, 5987.491063259672, 5997.280326360865, 5998.1602575639445, 5759.913601295984, 5818.738156782955, 5828.213191219216, 5834.912476312774, 5845.678487683133, 5729.255196824386, 5738.483536481736, 5763.6541807491685, 5769.8557536061935, 5771.0, 5657.0, 5679.858003549944, 5708.115242137475, 5723.971380143073, 5727.856803579861, 5850.268716410449, 5858.326292476335, 5861.9706901465215, 5863.296404431496, 5898.469137777621, 4486.528914463999, 4493.303537951622, 4497.392851964943, 4499.707519011319, 4525.660575456854, 3968.7420317679257, 4004.819783109767, 4011.4584531088512, 4049.453323801308, 4068.450759147477, 5553.972230138905, 5576.581756368289, 5578.386377498472, 5578.497935185853, 5597.160425936142, 5854.765809367577, 5855.0, 5889.793857214977, 5895.823125306248, 5899.911501327483, 5395.676259424447, 5510.228568000483, 5525.143602741581, 5594.916076258859, 5596.524295434852, 4970.850874473772, 5011.123053465629, 5015.14742493777, 5016.197408414636, 5053.873653158627, 6119.938800611937, 6134.6625935573975, 6158.969205154035, 6159.353267906895, 6160.1375807387, 5740.311162660424, 5843.649381037151, 5854.209681692917, 5921.052631578927, 5929.0513517836935, 5992.340842507408, 6022.247219097613, 6027.909581356371, 6031.879362412815, 6032.547558933185, 5623.0, 5738.885222295614, 5742.7702891883855, 5752.654840709571, 5756.1941328214925, 5866.911996319973, 5901.881962360814, 5916.881662366643, 5918.852028699317, 5986.16193732869, 5656.6888821115235, 5662.546996240373, 5680.2047713321, 5685.658860468385, 5691.544676425793, 5564.777408903598, 5680.204771331934, 5689.459501347365, 5692.117721753135, 5717.142428635738, 5552.916706249329, 5564.10974244119, 5567.832965011056, 5585.664860108406, 5602.52378547828, 5654.7455364509515, 5657.179708942263, 5664.603477756517, 5665.971670141623, 5697.715114244188, 5490.368607610176, 5520.944790552043, 5552.7778888843995, 5584.246126772834, 5636.774529018793], "value": 5399.272826428238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.7504973060508, 662.8541720821418, 665.6771465839064, 677.4546490075489, 739.6006156675395, 32330.515042274354, 32865.67134328656, 40279.0, 40973.180536389256, 41369.0, 43792.78103609478, 44278.335824962654, 44326.0, 44390.33414498785, 44422.0, 7563.962180189092, 8736.650533978633, 8910.153535414125, 8912.688055918044, 10329.328593641389, 10412.479376031206, 10533.05202531772, 10550.894491055067, 10561.049505544499, 10561.683149505527, 10569.788604227911, 10659.307145035587, 10660.520276587533, 10661.413622250773, 10661.626843060494, 10494.947525262402, 10559.947200263949, 10583.10043646291, 10585.0, 10590.523426445829, 10314.896851031544, 10728.678139655824, 10739.677809665722, 10757.085647719954, 10768.623098191525, 43284.56715432868, 43784.343234851505, 43864.561354386366, 43883.12233755307, 43905.34141987873, 3912.1393293475676, 4346.174226896879, 4368.47578290604, 4478.2386994211065, 4685.0395668887795, 33102.0, 33992.83003584966, 34172.14569635754, 34702.13244668904, 35344.46983295253, 4575.107853968478, 4579.381783459224, 4608.23964045932, 4615.653825963032, 4642.489326174118, 329098.0, 329770.0, 330592.9999999976, 331278.0, 333309.0, 38530.22939541194, 61207.693961529905, 62041.68979155165, 62121.689391552754, 62156.0, 37103.4434483483, 37173.0, 37235.441468378, 37321.81339093287, 37382.43926341107, 16704.08127552972, 16880.577985550215, 16888.240029198714, 16892.324307027826, 16893.324267029428, 13019.47922083125, 14628.707425851424, 15022.49775022511, 15036.248187590576, 15056.096634201984, 8963.0, 8987.281017518582, 8991.41555798871, 9012.549372531346, 9045.77385565353, 3492.284081763283, 3512.5082488451635, 3512.8946131616094, 3516.1033936346066, 3607.7294202934886, 966.2704657983178, 1141.2182654881433, 1166.3293606176483, 1204.325577676504, 1251.2805137046234, 33111.16103746954, 33116.503252451235, 33385.332293354, 33661.326773464396, 33836.154096147795, 1141.5319718915205, 1176.3236139219982, 1226.7485165541043, 1248.6254123762835, 1252.9976019184617, 16243.106629135274, 16248.59378515523, 16251.431199908184, 16267.349306027863, 16550.08974506414, 514094.0, 518361.0, 519828.0, 520518.0, 521365.0, 59284.0, 59887.40112598818, 59933.70033149806, 59969.40030599725, 60088.69955650194, 1345.2399394342165, 1486.9628608806006, 1527.793747844027, 1536.8924175307845, 1599.4561848971405, 30121.698783012765, 30273.65707176391, 32283.19292017718, 32301.192470188435, 33364.83317583396, 50768.74615627046, 51601.741991289804, 51740.482595175075, 51771.48228517817, 51878.48121518888, 359609.0, 363078.0, 365238.0, 366241.0, 366361.0, 26007.219783406526, 26338.07816726482, 29396.853015734785, 29423.85288073546, 29983.850080749457, 43620.505959017566, 43811.0, 44044.33933491064, 44674.77662611666, 44872.32691509565, 37145.628543714214, 37233.0, 37534.43698344472, 38909.41635875521, 40548.59451405448, 38277.23445531018, 39906.0, 40125.39811902765, 40272.597274026884, 40925.0, 40179.461615154534, 40188.79905600454, 41587.0, 41765.0, 41898.79050604728, 34221.82889085539, 35305.47041794324, 35445.0, 36227.0, 36289.45565816462, 27681.72318276872, 28048.43903121885, 28128.0, 28197.0, 28290.43419131647], "value": 19614.954265590102, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.63631822155605, 429.795846972688, 433.2310149484666, 434.71091724003537, 443.436884980444, 18442.446726598206, 18972.241110355586, 19061.237550497997, 19293.421197364067, 20145.697814532756, 12188.268703877773, 12438.875611243884, 13202.933985330084, 19583.706244406345, 19596.0, 5300.681959082467, 5320.9467905321035, 5457.590680698943, 5487.0, 5498.725063746817, 5367.0, 5392.272043274166, 5409.513143817056, 5418.972905135469, 5437.211604317372, 5411.540019098381, 5420.349558053039, 5420.430854760233, 5426.21319908613, 5426.21319908613, 5192.636515443921, 5457.645253058578, 5461.590380721442, 5462.180672899057, 5463.235147079412, 5297.655652382583, 5311.389190243133, 5317.9468205317835, 5318.547923426513, 5322.65402748824, 18095.547611309823, 22784.77215227843, 23312.883435582884, 23633.409164770845, 23722.40693982647, 2393.748656391089, 2418.600930846408, 2468.419921318489, 2551.553478141318, 2592.5981472871736, 10290.794184116276, 10643.201759868041, 10809.297395669257, 12208.0, 14662.706745865024, 1948.2012374926212, 1988.602279544097, 2000.3098930868828, 2038.7247721557549, 2053.4558342039372, 59146.0, 62658.68670656663, 75949.62025189894, 76428.23571764267, 79423.0, 10439.478026098664, 10553.84169237462, 10696.679099626868, 10728.498010278567, 10868.510917008754, 15123.924380378028, 15185.088894666356, 15231.695366092616, 15232.0, 15244.923775381274, 7713.0, 8599.699010534601, 8715.346349023848, 8718.346124040723, 8944.776380590538, 8820.191860668547, 8906.109389061043, 8946.150115738994, 9022.278217742565, 9051.954740226256, 4722.504137065627, 4727.054589082198, 4755.714657120584, 4773.427188737304, 4860.635452341088, 1981.682930731076, 2009.9899500502697, 2026.1996511377922, 2071.492484341346, 2100.3488918435332, 1007.3804610164696, 1032.9276950613385, 1075.6289080267295, 1086.7283179205199, 1158.0793269350886, 18604.720929186074, 18769.436916892515, 18837.434876953714, 19156.425307240806, 19163.520911977314, 1045.0803293102022, 1078.735709751116, 1143.0912424622445, 1148.1618418554501, 1189.3696340939316, 10453.947730261452, 10800.405977671146, 10812.513436895359, 10872.238943273895, 10895.455227238765, 470709.0, 569113.0, 584150.0, 586032.0, 596153.0, 87955.0, 90310.0, 97063.51468242613, 98006.0, 98264.50867745615, 1082.723905404117, 1103.6082190822303, 1134.3987686525988, 1159.8492196014633, 1169.6432588060723, 16698.4155554555, 17129.314827406764, 17987.19057642383, 17999.910000449912, 18027.549311267325, 40386.596134038286, 41698.374524382765, 41886.37170442385, 42510.362344565474, 42587.148257035304, 55690.0, 56722.43277567172, 57117.42882571121, 57144.0, 57282.713586431804, 8742.256908162622, 8786.516741579275, 8989.190972812217, 9015.954920225357, 9048.547572621212, 9559.474228917476, 12973.805392919303, 13856.93071534636, 14086.577402677936, 14302.499412520512, 11860.76278474443, 12027.939860300643, 12060.879391205975, 12462.202594095459, 12466.252024878537, 11888.34614096233, 12008.879911200776, 12053.879461205275, 12112.333821639895, 12231.449584768528, 12168.57409990646, 12390.75218495607, 12411.255324680547, 12501.624951251477, 12699.809502857279, 8576.828463430822, 8880.37837351405, 9064.761781756191, 9193.724188274362, 9195.126462986005, 10730.356178629307, 11465.14011449128, 11603.245789023686, 11638.53445862156, 11734.471948762497], "value": 9340.092902024284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.517726207197, 1587.88090893183, 1611.86299164571, 1858.9349372771956, 1914.9425517234479, 8338.416310858234, 8497.150284971514, 8523.147685231474, 8539.316854651628, 8550.52972086535, 8387.412881098326, 8566.828663426742, 8567.443116197443, 8569.871451928226, 8571.699990500334, 2419.250032489925, 2435.5007223519137, 2435.866027368494, 2441.414060625446, 2442.9022839086415, 2399.78401943825, 2448.6204638281097, 2469.444375015616, 2473.567125752986, 2481.2928315430104, 2379.1078345620394, 2419.8185136114776, 2425.0663494554547, 2430.987845060772, 2434.6469761884514, 2366.9053237870635, 2412.2883749294, 2417.7703118203744, 2423.7455067217866, 2429.5626787178303, 2413.1433341163984, 2455.4475243070347, 2474.0969546115716, 2474.307193985687, 2478.6901637295337, 6964.164300283998, 8203.384746144004, 8671.13288671134, 8716.520591367473, 8723.60743766532, 5269.130593452076, 5455.481729235756, 5457.536109430703, 5458.863528411782, 5466.617336786427, 3566.8394922228563, 3578.2127931854952, 3639.581448133472, 3756.3426400379826, 3798.392257238856, 1137.056243318044, 1138.7210133517342, 1157.0107558037926, 1174.9530018799237, 1178.917475776696, 12428.316442595744, 12434.875651243552, 12527.686807829787, 12528.937355313165, 12540.561080362144, 4668.906621867543, 4733.573978341966, 4764.809407623726, 4771.73755443447, 4804.591609713144, 10466.63366782159, 10470.947645261876, 10480.0, 10480.790384192425, 10492.685219443429, 5322.92015619766, 5324.254604355393, 5346.037713211659, 5350.956563470086, 5357.651752636066, 4803.903921921612, 4818.469968303554, 4818.951810481921, 4820.30105634681, 4822.517748225149, 3799.50606421169, 3990.1421194443333, 4000.3799411091327, 4002.3596224603925, 4041.2523683118716, 1309.4434865182259, 1311.4819646239873, 1311.6065180445828, 1325.9602211933657, 1332.9466821327233, 1007.7531004903846, 1038.3925403638955, 1056.2131212246925, 1068.6687126990657, 1074.4520294649628, 5993.0710739835395, 6003.189569408161, 6029.547783916136, 6057.121717350959, 6310.432061114522, 455.7425054844002, 459.9310103484437, 469.9365585645962, 474.02351156617476, 480.74280260061397, 4203.47456567929, 4214.726042807208, 4240.554741752133, 4272.33778764292, 4327.199468098412, 10203.94898025505, 10571.312864663925, 10645.84031239532, 10653.627123050655, 10665.626703065356, 10471.581136754445, 10485.37087774736, 10486.842697359545, 10506.527206275736, 10510.264281500222, 7941.285284324438, 8104.797380065545, 8209.014918209854, 8214.219649133323, 8223.301019413297, 6051.304100028553, 6051.848703782441, 6109.7861574844665, 6128.9693551531955, 6226.62640241587, 9249.12133347331, 9333.533323333942, 9401.482918439551, 9436.858447123435, 9511.904880951379, 9192.667063275654, 9657.806843863224, 9677.177439917687, 9860.26048046385, 9965.701028969142, 7733.188015258317, 7771.37828973692, 7811.804704882424, 7818.179091195342, 7845.097813751491, 8347.874781878156, 8449.155084491502, 8474.449160804528, 8478.57607119654, 8501.362397820065, 7211.8557628848175, 7296.854062918605, 7384.556926584422, 7435.442341824493, 7510.061242344707, 7413.2957369049855, 7431.554106753612, 7449.515781474187, 7544.47188696786, 7589.051368578927, 6809.965950170217, 6857.55425897315, 6919.100516932968, 6921.8961715575315, 6941.861162776615, 4536.637069034536, 5301.151815709468, 5389.946100538945, 5397.352317721741, 5461.754221059982, 5174.741262936914, 5200.479952004921, 5219.8434046978655, 5322.802369466839, 5343.438938911514], "value": 4598.947353231426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.84311530465374, 352.83769466045624, 354.6063869105294, 354.8030842882199, 356.1239351196058, 6130.11113388559, 6156.938430615693, 6191.783287584935, 6307.274663413708, 6318.652474113922, 6133.938660613392, 6141.754329826813, 6189.442950134487, 6191.690415479219, 6230.470410015143, 4691.554302341272, 4694.788734506938, 4694.882627934312, 4697.084068606623, 4698.530146985291, 4486.102779444108, 4570.291604801261, 4639.814407423699, 4688.179568575502, 4722.598579120779, 4653.4881163072205, 4665.603423708972, 4668.18306796311, 4670.252759558472, 4679.461861885876, 4437.179121862466, 4660.324252983315, 4660.580547750685, 4661.813527458931, 4662.953370466286, 3976.0258736609426, 4026.879193624196, 4047.3928910663635, 4055.5944405559503, 4057.0, 5821.476067153934, 5825.213596164506, 5897.8820423591715, 5917.644941303535, 5918.053111502182, 5390.6226564140525, 5420.945790542123, 5430.294061771984, 5435.483629055233, 5438.401775804658, 6483.384078512534, 6484.124643173205, 6485.156929599122, 6487.0, 6496.805095847132, 4535.229011068126, 4537.0925814837165, 4539.863804085882, 4544.909101817978, 4550.249208880531, 6602.86794264112, 6805.455563554904, 6806.6256355900905, 6817.250102488672, 6817.931820681779, 4583.0, 4630.143423466669, 4630.259158534685, 4641.698289611165, 4646.233371493666, 4702.600278976325, 4705.411823522059, 4706.1999460091865, 4708.741019243906, 4711.929321060187, 5416.593755468356, 5422.864428389243, 5446.101393270066, 5448.56411487088, 5456.836294911159, 6555.082288479522, 6560.3111673273615, 6565.441937435276, 6569.934300657028, 6573.934260657332, 1570.1050401271166, 1639.6392793585392, 1640.4176517336412, 1640.958976025609, 1641.4747280870006, 1045.0646671229208, 1046.6912260883057, 1054.799588078278, 1055.1400608504046, 1059.750958524746, 6099.969500152471, 6209.06863970399, 6233.3143354231, 6278.215223097113, 6378.0, 6770.0, 6775.864482710318, 6779.49153813466, 6829.317068293131, 6832.863342733217, 6347.619142851351, 6356.713947872357, 6359.268684101295, 6360.459360954371, 6368.267649220306, 3597.6941959933697, 3633.9818300908855, 3638.4360424133774, 3640.4903313536124, 3641.5448068991377, 6923.5499692519825, 7052.92947070533, 7075.752348667875, 7077.92922070783, 7080.575165489984, 6852.143482064742, 6871.553349032297, 6881.483888708367, 6886.035954966309, 6890.586564806128, 7074.540154889915, 7076.32774886385, 7095.964520177469, 7104.502684812013, 7106.467014973898, 6741.730330786713, 6742.595444273359, 6744.662766861539, 6747.089142965637, 6754.3921047106, 6547.443467305332, 6653.833654158685, 6679.56582822115, 6679.799606011828, 6696.464282857457, 7046.823829404306, 7095.467839911924, 7095.503314767917, 7098.0, 7104.467164962545, 4564.42944631921, 4569.862904112882, 4576.130535198302, 4578.839740609063, 4580.267157254823, 6678.966605166943, 6687.297833727584, 6689.896167132369, 6690.83272918181, 6694.966525167343, 6514.706838192198, 6531.836704082246, 6552.08270842092, 6566.474682025331, 6573.079768832463, 6347.968260158855, 6582.473402127723, 6586.637734924433, 6592.637404942774, 6595.175603049619, 6415.486761059011, 6462.642845002602, 6478.481721462366, 6479.773207937699, 6485.383888530582, 6578.736850525926, 6614.6361950093205, 6616.867662646817, 6618.768343107968, 6626.105475760711, 6445.774397896051, 6449.226092868886, 6456.741730330734, 6460.289368169591, 6463.482921366373], "value": 4922.483594160663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.8018075661839, 875.6541166239335, 891.2424439226662, 919.976052684095, 926.6247169896192, 15177.620559486018, 15334.0, 15343.769843452343, 15370.077795332274, 15386.076835389857, 13937.790933136012, 14044.087134336261, 14072.366743496541, 14094.647633809134, 14110.929445352784, 749.2395218852841, 901.8286525560155, 910.8269428808521, 915.3866909170838, 922.5894476957723, 922.7231830450871, 926.4626516620377, 927.1099744245532, 927.4249965021696, 931.3899395895666, 968.1238479176357, 968.3608818180003, 968.5351031504882, 968.7142293023575, 969.1616751509964, 766.8811334243173, 960.4477425480306, 963.032152686549, 964.0841200859177, 980.294188184506, 713.2190251674408, 714.696254092014, 716.2765606737233, 716.6989864257024, 716.7813816785879, 14525.346359413852, 14581.48964786238, 14592.781108283385, 14593.708125837424, 14596.781048284285, 13593.524226652118, 14196.858031419657, 14208.857911420857, 14472.059316144418, 14606.415743370253, 11846.407679616072, 12006.759864802654, 12177.147599668027, 12194.81707774384, 12531.436085376088, 4014.197160567898, 4039.071013666873, 4050.858219962287, 4073.816678249486, 4157.168566286755, 55332.72333638346, 55671.0, 56735.71632141854, 57342.7132864333, 58200.70899645517, 12039.097067719957, 12044.156909016285, 12172.452239649238, 12180.695482612828, 12240.44917978693, 22003.33989980303, 22139.0, 22154.667679984814, 22193.001314940866, 22217.0, 8850.34909434241, 8952.060033696498, 8999.10008999108, 9131.406458580172, 9351.579178936965, 4910.238912968495, 5014.89970200594, 5056.974715126401, 5057.519535644108, 5074.06129865976, 3631.1829838286176, 3732.9626703732615, 3736.514253147128, 3743.419769935664, 3745.8127093645207, 701.8876979683329, 705.9188193357727, 721.2607077745353, 723.8479919217024, 725.9128904531384, 742.7363286033489, 742.7660287009575, 757.7499425189784, 762.0017776712524, 778.1207235823483, 9633.90366096344, 9844.80310393788, 10144.92753623189, 10201.236301489635, 10465.633702820365, 701.3652644356865, 828.3869936247133, 829.1128492512953, 849.9745007649657, 851.1871163039283, 4555.817767289272, 4609.943131155028, 4656.138614356355, 4708.223143181405, 4735.337052812609, 67208.6639566799, 67448.0, 67557.98663020058, 67585.32414675888, 67741.0, 54993.0, 55582.16626750602, 56292.0, 56365.0, 56615.0, 52496.21255681244, 52577.474225258025, 52981.47018529842, 53516.73241633767, 54432.0, 10206.23453240995, 10209.897901020895, 10248.077673009466, 10443.582256709646, 10478.37129772216, 39495.407568885916, 39533.604663952996, 39703.40444893387, 40579.59420405876, 41390.1721965565, 46664.30003550017, 47225.0, 51516.0, 52712.0, 53464.0, 12917.28954907489, 12946.935265323613, 12984.480620775063, 13105.80886945659, 13294.268815215257, 13207.867921320663, 13535.458581656623, 13798.0, 14019.789703154256, 14787.260636968324, 13465.798013029616, 13646.727065458834, 13726.176429414267, 13946.58160255194, 14425.42298308056, 12884.871151288367, 13115.803262950873, 13161.144525605805, 13391.464341426623, 14202.857971420153, 13647.931760341135, 13678.93160534191, 13734.45062197541, 13827.86172138306, 13895.722085558435, 11276.887231127585, 11369.488373023069, 11449.370284634426, 11560.13299002595, 11676.474558644712, 11312.60405885823, 11333.943330283295, 11614.6515604532, 11680.707982300171, 11792.52829886795], "value": 7330.991698891315, "unit": "score"}], "name": "dromaeo_css", "value": 7399.794734844163, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 112.0, 111.0, 112.0, 106.0, 109.0, 111.0, 109.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 154.0, 172.0, 128.0, 163.0, 161.0, 126.0, 183.0, 130.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 163.0, 161.0, 162.0, 162.0, 160.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 174.0, 76.0, 77.0, 72.0, 75.0, 164.0, 73.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 157.0, 91.0, 91.0, 92.0, 146.0, 91.0, 91.0, 141.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 52.0, 53.0, 53.0, 53.0, 54.0, 71.0, 50.0, 53.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 58.0, 57.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 72.0, 73.0, 73.0, 72.0, 73.0, 72.0, 72.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 112.0, 113.0, 121.0, 127.0, 115.0, 122.0, 130.0, 114.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 158.0, 163.0, 158.0, 159.0, 161.0, 160.0, 158.0, 163.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 67.0, 65.0, 65.0, 75.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1512.9000000000003, "alertThreshold": 2.0}]} 10:50:52 INFO - Return code: 0 10:50:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:50:52 ERROR - # TBPL SUCCESS # 10:50:52 INFO - Running post-action listener: _resource_record_post_action 10:50:52 INFO - Running post-run listener: _resource_record_post_run 10:50:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 40960; Write bytes: 469729280; Read time: 264; Write time: 463752 10:50:53 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 253460480; Read time: 0; Write time: 302020 10:50:53 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 215670784; Read time: 248; Write time: 161732 10:50:53 INFO - Running post-run listener: _upload_blobber_files 10:50:53 INFO - Blob upload gear active. 10:50:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:50:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:50:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:54 INFO - (blobuploader) - INFO - Done attempting. 10:50:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:50:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:50:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:55 INFO - (blobuploader) - INFO - Done attempting. 10:50:55 INFO - (blobuploader) - INFO - Iteration through files over. 10:50:55 INFO - Return code: 0 10:50:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:50:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:50:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25a3b26eff35a5250532b01eada4ec81e1e3894b2caa4ebe504a35277ddc5c6b2c51791dc3acd0b7e99bf56581f6f39acd4648ed5206f365d21e2b4760556a48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1277968d981ef6c1d4be73176fe98926d31cff0665723c106b2f765b8e1bec756fcc0e12f9a092de16d49390b116c9e88d7bce1d6a8e02ede292b501ed2bd9fc"} 10:50:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:50:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:50:55 INFO - Contents: 10:50:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25a3b26eff35a5250532b01eada4ec81e1e3894b2caa4ebe504a35277ddc5c6b2c51791dc3acd0b7e99bf56581f6f39acd4648ed5206f365d21e2b4760556a48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1277968d981ef6c1d4be73176fe98926d31cff0665723c106b2f765b8e1bec756fcc0e12f9a092de16d49390b116c9e88d7bce1d6a8e02ede292b501ed2bd9fc"} 10:50:55 INFO - Running post-run listener: copy_logs_to_upload_dir 10:50:55 INFO - Copying logs to upload dir... 10:50:55 INFO - mkdir: /builds/slave/test/build/upload/logs 10:50:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.281929 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-07-06 10:50:55.124111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:50:55.127984) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25a3b26eff35a5250532b01eada4ec81e1e3894b2caa4ebe504a35277ddc5c6b2c51791dc3acd0b7e99bf56581f6f39acd4648ed5206f365d21e2b4760556a48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1277968d981ef6c1d4be73176fe98926d31cff0665723c106b2f765b8e1bec756fcc0e12f9a092de16d49390b116c9e88d7bce1d6a8e02ede292b501ed2bd9fc"} build_url:https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/bjNdNn19Scy1vEKSaLb_VQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25a3b26eff35a5250532b01eada4ec81e1e3894b2caa4ebe504a35277ddc5c6b2c51791dc3acd0b7e99bf56581f6f39acd4648ed5206f365d21e2b4760556a48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1277968d981ef6c1d4be73176fe98926d31cff0665723c106b2f765b8e1bec756fcc0e12f9a092de16d49390b116c9e88d7bce1d6a8e02ede292b501ed2bd9fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 10:50:55.154022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:50:55.154430) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467826229.49806-1346571879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 10:50:55.237519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:50:55.237844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 10:50:55.238144) ========= ========= Total master_lag: 0.18 =========