builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1467821066.77 results: success (0) buildid: 20160706061822 builduid: 533aec527d9f42bfb5d1d00145bc3c81 revision: cda06c358893d526741f3165800d3406111749bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.773276) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.773740) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.774015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.789983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.790301) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 09:04:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.5M=0s 2016-07-06 09:04:27 (44.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.925580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.925937) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013897 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.975675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:26.976051) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cda06c358893d526741f3165800d3406111749bc --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 cda06c358893d526741f3165800d3406111749bc --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=bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 09:04:27,644 truncating revision to first 12 chars 2016-07-06 09:04:27,644 Setting DEBUG logging. 2016-07-06 09:04:27,644 attempt 1/10 2016-07-06 09:04:27,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cda06c358893?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 09:04:27,972 unpacking tar archive at: mozilla-beta-cda06c358893/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:27.660340) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:27.660694) ========= script_repo_revision: cda06c358893d526741f3165800d3406111749bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:27.661101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:27.661376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:04:27.672196) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-06 09:04:27.672590) ========= /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=bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:28 INFO - MultiFileLogger online at 20160706 09:04:28 in /builds/slave/test 09:04:28 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 09:04:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:28 INFO - {'append_to_log': False, 09:04:28 INFO - 'base_work_dir': '/builds/slave/test', 09:04:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:04:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:28 INFO - 'branch': 'Mozilla-Beta', 09:04:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:28 INFO - 'config_files': ('talos/linux_config.py',), 09:04:28 INFO - 'default_actions': ('clobber', 09:04:28 INFO - 'read-buildbot-config', 09:04:28 INFO - 'download-and-extract', 09:04:28 INFO - 'populate-webroot', 09:04:28 INFO - 'create-virtualenv', 09:04:28 INFO - 'install', 09:04:28 INFO - 'run-tests'), 09:04:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:28 INFO - 'download_minidump_stackwalk': True, 09:04:28 INFO - 'download_symbols': 'ondemand', 09:04:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:28 INFO - 'installer_path': 'installer.exe', 09:04:28 INFO - 'log_level': 'info', 09:04:28 INFO - 'log_name': 'talos', 09:04:28 INFO - 'log_to_console': True, 09:04:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:28 INFO - 'opt_config_files': (), 09:04:28 INFO - 'pip_index': False, 09:04:28 INFO - 'sps_profile': False, 09:04:28 INFO - 'sps_profile_interval': 0, 09:04:28 INFO - 'suite': 'dromaeojs', 09:04:28 INFO - 'system_bits': '32', 09:04:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:28 INFO - 'title': 'talos-linux64-ix-055', 09:04:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:28 INFO - 'use_talos_json': True, 09:04:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:28 INFO - 'work_dir': 'build'} 09:04:28 INFO - ##### 09:04:28 INFO - ##### Running clobber step. 09:04:28 INFO - ##### 09:04:28 INFO - Running pre-action listener: _resource_record_pre_action 09:04:28 INFO - Running main action method: clobber 09:04:28 INFO - rmtree: /builds/slave/test/build 09:04:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:28 INFO - Running post-action listener: _resource_record_post_action 09:04:28 INFO - ##### 09:04:28 INFO - ##### Running read-buildbot-config step. 09:04:28 INFO - ##### 09:04:28 INFO - Running pre-action listener: _resource_record_pre_action 09:04:28 INFO - Running main action method: read_buildbot_config 09:04:28 INFO - Using buildbot properties: 09:04:28 INFO - { 09:04:28 INFO - "project": "", 09:04:28 INFO - "product": "firefox", 09:04:28 INFO - "script_repo_revision": "production", 09:04:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:04:28 INFO - "repository": "", 09:04:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:04:28 INFO - "buildid": "20160706061822", 09:04:28 INFO - "pgo_build": "True", 09:04:28 INFO - "basedir": "/builds/slave/test", 09:04:28 INFO - "buildnumber": 92, 09:04:28 INFO - "slavename": "talos-linux64-ix-055", 09:04:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:04:28 INFO - "platform": "ubuntu64_hw", 09:04:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:04:28 INFO - "branch": "mozilla-beta", 09:04:28 INFO - "repo_path": "releases/mozilla-beta", 09:04:28 INFO - "revision": "cda06c358893d526741f3165800d3406111749bc", 09:04:28 INFO - "stage_platform": "linux64-pgo", 09:04:28 INFO - "builduid": "533aec527d9f42bfb5d1d00145bc3c81", 09:04:28 INFO - "slavebuilddir": "test" 09:04:28 INFO - } 09:04:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:04:28 INFO - Running post-action listener: _resource_record_post_action 09:04:28 INFO - ##### 09:04:28 INFO - ##### Running download-and-extract step. 09:04:28 INFO - ##### 09:04:28 INFO - Running pre-action listener: _resource_record_pre_action 09:04:28 INFO - Running main action method: download_and_extract 09:04:28 INFO - mkdir: /builds/slave/test/build/tests 09:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:28 INFO - https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:29 INFO - Downloaded 1327 bytes. 09:04:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:04:29 INFO - Using the following test package requirements: 09:04:29 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:04:29 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:29 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:04:29 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:04:29 INFO - u'jsshell-linux-x86_64.zip'], 09:04:29 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:29 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:04:29 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:04:29 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:04:29 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:29 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:04:29 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:29 INFO - https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:30 INFO - Downloaded 24236019 bytes. 09:04:30 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'] 09:04:30 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 09:04:31 INFO - Return code: 0 09:04:31 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 09:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:31 INFO - https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:32 INFO - Downloaded 24236019 bytes. 09:04:32 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'] 09:04:32 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 09:04:34 INFO - Return code: 0 09:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:34 INFO - https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:35 INFO - Downloaded 10840145 bytes. 09:04:35 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'] 09:04:35 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 09:04:35 INFO - Return code: 0 09:04: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')]} 09:04:35 INFO - https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRUxByAXRlGB18mDv1RSDQ/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 09:04:36 INFO - Downloaded 56018504 bytes. 09:04:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:04:36 INFO - mkdir: /builds/slave/test/properties 09:04:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:36 INFO - Contents: 09:04:36 INFO - build_url:https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:04:37 INFO - Running post-action listener: _resource_record_post_action 09:04:37 INFO - Running post-action listener: set_extra_try_arguments 09:04:37 INFO - ##### 09:04:37 INFO - ##### Running populate-webroot step. 09:04:37 INFO - ##### 09:04:37 INFO - Running pre-action listener: _resource_record_pre_action 09:04:37 INFO - Running main action method: populate_webroot 09:04:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:37 INFO - '--tppagecycles', 09:04:37 INFO - '7'], 09:04:37 INFO - 'tests': ['tsvgm']}}, 09:04:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:37 INFO - 'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:37 INFO - 'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['damp', 'tps']}, 09:04:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:37 INFO - 'tests': ['damp', 'tps']}, 09:04:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['dromaeo_dom']}, 09:04:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['a11yr', 09:04:37 INFO - 'ts_paint', 09:04:37 INFO - 'tpaint', 09:04:37 INFO - 'sessionrestore', 09:04:37 INFO - 'sessionrestore_no_auto_restore', 09:04:37 INFO - 'tabpaint']}, 09:04:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:37 INFO - 'ts_paint', 09:04:37 INFO - 'tpaint', 09:04:37 INFO - 'sessionrestore', 09:04:37 INFO - 'sessionrestore_no_auto_restore', 09:04:37 INFO - 'tabpaint']}, 09:04:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:37 INFO - 'ts_paint', 09:04:37 INFO - 'tpaint', 09:04:37 INFO - 'sessionrestore', 09:04:37 INFO - 'sessionrestore_no_auto_restore', 09:04:37 INFO - 'tabpaint']}, 09:04:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:37 INFO - 'ts_paint', 09:04:37 INFO - 'tpaint', 09:04:37 INFO - 'sessionrestore', 09:04:37 INFO - 'sessionrestore_no_auto_restore', 09:04:37 INFO - 'tabpaint']}, 09:04:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['a11yr', 09:04:37 INFO - 'ts_paint', 09:04:37 INFO - 'tpaint', 09:04:37 INFO - 'sessionrestore', 09:04:37 INFO - 'sessionrestore_no_auto_restore', 09:04:37 INFO - 'tabpaint']}, 09:04:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['a11yr', 09:04:37 INFO - 'ts_paint', 09:04:37 INFO - 'tpaint', 09:04:37 INFO - 'sessionrestore', 09:04:37 INFO - 'sessionrestore_no_auto_restore', 09:04:37 INFO - 'tabpaint']}, 09:04:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['tsvgx', 09:04:37 INFO - 'tsvgr_opacity', 09:04:37 INFO - 'tart', 09:04:37 INFO - 'tscrollx', 09:04:37 INFO - 'cart']}, 09:04:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:37 INFO - 'tsvgr_opacity', 09:04:37 INFO - 'tart', 09:04:37 INFO - 'tscrollx', 09:04:37 INFO - 'cart']}, 09:04:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:37 INFO - 'talos_options': ['--disable-e10s'], 09:04:37 INFO - 'tests': ['tp5o']}, 09:04:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:37 INFO - 'tests': ['tp5o']}, 09:04:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:37 INFO - 'talos_options': ['--disable-e10s', 09:04:37 INFO - '--xperf_path', 09:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:37 INFO - 'tests': ['tp5n']}, 09:04:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:37 INFO - 'talos_options': ['--xperf_path', 09:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:37 INFO - 'tests': ['tp5n']}}, 09:04:37 INFO - 'talos.zip': {'path': '', 09:04:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:37 INFO - Running post-action listener: _resource_record_post_action 09:04:37 INFO - ##### 09:04:37 INFO - ##### Running create-virtualenv step. 09:04:37 INFO - ##### 09:04:37 INFO - Running pre-action listener: _resource_record_pre_action 09:04:37 INFO - Running main action method: create_virtualenv 09:04:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:37 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 09:04:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:37 INFO - Using real prefix '/usr' 09:04:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:40 INFO - Installing pip.................done. 09:04:40 INFO - Return code: 0 09:04:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:04:40 INFO - Using env: {'DISPLAY': ':0', 09:04:40 INFO - 'HOME': '/home/cltbld', 09:04:40 INFO - 'LANG': 'en_US.UTF-8', 09:04:40 INFO - 'LANGUAGE': 'en_US:en', 09:04:40 INFO - 'LOGNAME': 'cltbld', 09:04:40 INFO - 'MAIL': '/var/mail/cltbld', 09:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:40 INFO - 'MOZ_NO_REMOTE': '1', 09:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:40 INFO - 'NO_EM_RESTART': '1', 09:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:40 INFO - 'PWD': '/builds/slave/test', 09:04:40 INFO - 'SHELL': '/bin/bash', 09:04:40 INFO - 'SHLVL': '1', 09:04:40 INFO - 'TERM': 'linux', 09:04:40 INFO - 'TMOUT': '86400', 09:04:40 INFO - 'USER': 'cltbld', 09:04:40 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:40 INFO - '_': '/tools/buildbot/bin/python'} 09:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:40 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 09:04:40 INFO - Cleaning up... 09:04:40 INFO - Return code: 0 09:04:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:04:40 INFO - Using env: {'DISPLAY': ':0', 09:04:40 INFO - 'HOME': '/home/cltbld', 09:04:40 INFO - 'LANG': 'en_US.UTF-8', 09:04:40 INFO - 'LANGUAGE': 'en_US:en', 09:04:40 INFO - 'LOGNAME': 'cltbld', 09:04:40 INFO - 'MAIL': '/var/mail/cltbld', 09:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:40 INFO - 'MOZ_NO_REMOTE': '1', 09:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:40 INFO - 'NO_EM_RESTART': '1', 09:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:40 INFO - 'PWD': '/builds/slave/test', 09:04:40 INFO - 'SHELL': '/bin/bash', 09:04:40 INFO - 'SHLVL': '1', 09:04:40 INFO - 'TERM': 'linux', 09:04:40 INFO - 'TMOUT': '86400', 09:04:40 INFO - 'USER': 'cltbld', 09:04:40 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:40 INFO - '_': '/tools/buildbot/bin/python'} 09:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:40 INFO - Downloading/unpacking psutil>=0.7.1 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:42 INFO - Installing collected packages: psutil 09:04:42 INFO - Running setup.py install for psutil 09:04:42 INFO - building 'psutil._psutil_linux' extension 09:04:42 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 09:04:42 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 09:04:42 INFO - building 'psutil._psutil_posix' extension 09:04:42 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 09:04:43 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 09:04:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:43 INFO - Successfully installed psutil 09:04:43 INFO - Cleaning up... 09:04:43 INFO - Return code: 0 09:04:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:04:43 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')]} 09:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:43 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')]} 09:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:43 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 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:43 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 09:04:43 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 09:04:43 INFO - Using env: {'DISPLAY': ':0', 09:04:43 INFO - 'HOME': '/home/cltbld', 09:04:43 INFO - 'LANG': 'en_US.UTF-8', 09:04:43 INFO - 'LANGUAGE': 'en_US:en', 09:04:43 INFO - 'LOGNAME': 'cltbld', 09:04:43 INFO - 'MAIL': '/var/mail/cltbld', 09:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:43 INFO - 'MOZ_NO_REMOTE': '1', 09:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:43 INFO - 'NO_EM_RESTART': '1', 09:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:43 INFO - 'PWD': '/builds/slave/test', 09:04:43 INFO - 'SHELL': '/bin/bash', 09:04:43 INFO - 'SHLVL': '1', 09:04:43 INFO - 'TERM': 'linux', 09:04:43 INFO - 'TMOUT': '86400', 09:04:43 INFO - 'USER': 'cltbld', 09:04:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:43 INFO - '_': '/tools/buildbot/bin/python'} 09:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:04:43 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 09:04:43 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 09:04:43 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 09:04:43 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 09:04:43 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 09:04:43 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 09:04:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:04:45 INFO - Installing collected packages: mozsystemmonitor 09:04:45 INFO - Running setup.py install for mozsystemmonitor 09:04:45 INFO - Successfully installed mozsystemmonitor 09:04:45 INFO - Cleaning up... 09:04:45 INFO - Return code: 0 09:04:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:04:45 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')]} 09:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:45 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')]} 09:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:45 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 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:45 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 09:04:45 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 09:04:45 INFO - Using env: {'DISPLAY': ':0', 09:04:45 INFO - 'HOME': '/home/cltbld', 09:04:45 INFO - 'LANG': 'en_US.UTF-8', 09:04:45 INFO - 'LANGUAGE': 'en_US:en', 09:04:45 INFO - 'LOGNAME': 'cltbld', 09:04:45 INFO - 'MAIL': '/var/mail/cltbld', 09:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:45 INFO - 'MOZ_NO_REMOTE': '1', 09:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:45 INFO - 'NO_EM_RESTART': '1', 09:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:45 INFO - 'PWD': '/builds/slave/test', 09:04:45 INFO - 'SHELL': '/bin/bash', 09:04:45 INFO - 'SHLVL': '1', 09:04:45 INFO - 'TERM': 'linux', 09:04:45 INFO - 'TMOUT': '86400', 09:04:45 INFO - 'USER': 'cltbld', 09:04:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:45 INFO - '_': '/tools/buildbot/bin/python'} 09:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:47 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 09:04:47 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 09:04:47 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 09:04:47 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 09:04:47 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 09:04:47 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 09:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04:48 INFO - Downloading docopt-0.6.1.tar.gz 09:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:48 INFO - Running setup.py install for blobuploader 09:04:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:48 INFO - Running setup.py install for requests 09:04:48 INFO - Running setup.py install for docopt 09:04:48 INFO - Successfully installed blobuploader requests docopt 09:04:48 INFO - Cleaning up... 09:04:48 INFO - Return code: 0 09:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 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 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:48 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 09:04:48 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 09:04:48 INFO - Using env: {'DISPLAY': ':0', 09:04:48 INFO - 'HOME': '/home/cltbld', 09:04:48 INFO - 'LANG': 'en_US.UTF-8', 09:04:48 INFO - 'LANGUAGE': 'en_US:en', 09:04:48 INFO - 'LOGNAME': 'cltbld', 09:04:48 INFO - 'MAIL': '/var/mail/cltbld', 09:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:48 INFO - 'MOZ_NO_REMOTE': '1', 09:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:48 INFO - 'NO_EM_RESTART': '1', 09:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:48 INFO - 'PWD': '/builds/slave/test', 09:04:48 INFO - 'SHELL': '/bin/bash', 09:04:48 INFO - 'SHLVL': '1', 09:04:48 INFO - 'TERM': 'linux', 09:04:48 INFO - 'TMOUT': '86400', 09:04:48 INFO - 'USER': 'cltbld', 09:04:48 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:48 INFO - '_': '/tools/buildbot/bin/python'} 09:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:49 INFO - Running setup.py (path:/tmp/pip-DsjCAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:49 INFO - Running setup.py (path:/tmp/pip-bANeLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:49 INFO - Running setup.py (path:/tmp/pip-0mRq4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:49 INFO - Running setup.py (path:/tmp/pip-XzlC8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:49 INFO - Running setup.py (path:/tmp/pip-zkDHNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:49 INFO - Running setup.py (path:/tmp/pip-KShlyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:49 INFO - Running setup.py (path:/tmp/pip-E4VW2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:49 INFO - Running setup.py (path:/tmp/pip-S7cbJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:49 INFO - Running setup.py (path:/tmp/pip-i37OrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:49 INFO - Running setup.py (path:/tmp/pip-0BqOuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:49 INFO - Running setup.py (path:/tmp/pip-XwHbhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:49 INFO - Running setup.py (path:/tmp/pip-tv_RCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:50 INFO - Running setup.py (path:/tmp/pip-i_Oo00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:50 INFO - Running setup.py (path:/tmp/pip-QKV74Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:50 INFO - Running setup.py (path:/tmp/pip-6OtqVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:50 INFO - Running setup.py (path:/tmp/pip-I9MCJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:50 INFO - Running setup.py (path:/tmp/pip-41DYEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:50 INFO - Running setup.py install for manifestparser 09:04:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:04:50 INFO - Running setup.py install for mozcrash 09:04:50 INFO - Running setup.py install for mozdebug 09:04:50 INFO - Running setup.py install for mozdevice 09:04:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:04:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:04:50 INFO - Running setup.py install for mozfile 09:04:50 INFO - Running setup.py install for mozhttpd 09:04:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Running setup.py install for mozinfo 09:04:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Running setup.py install for mozInstall 09:04:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Running setup.py install for mozleak 09:04:51 INFO - Running setup.py install for mozlog 09:04:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Running setup.py install for moznetwork 09:04:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Running setup.py install for mozprocess 09:04:51 INFO - Running setup.py install for mozprofile 09:04:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Running setup.py install for mozrunner 09:04:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Running setup.py install for mozscreenshot 09:04:51 INFO - Running setup.py install for moztest 09:04:52 INFO - Running setup.py install for mozversion 09:04:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:04:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:52 INFO - Cleaning up... 09:04:52 INFO - Return code: 0 09:04:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:52 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 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:52 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 09:04:52 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 09:04:52 INFO - Using env: {'DISPLAY': ':0', 09:04:52 INFO - 'HOME': '/home/cltbld', 09:04:52 INFO - 'LANG': 'en_US.UTF-8', 09:04:52 INFO - 'LANGUAGE': 'en_US:en', 09:04:52 INFO - 'LOGNAME': 'cltbld', 09:04:52 INFO - 'MAIL': '/var/mail/cltbld', 09:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:52 INFO - 'MOZ_NO_REMOTE': '1', 09:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:52 INFO - 'NO_EM_RESTART': '1', 09:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:52 INFO - 'PWD': '/builds/slave/test', 09:04:52 INFO - 'SHELL': '/bin/bash', 09:04:52 INFO - 'SHLVL': '1', 09:04:52 INFO - 'TERM': 'linux', 09:04:52 INFO - 'TMOUT': '86400', 09:04:52 INFO - 'USER': 'cltbld', 09:04:52 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:52 INFO - '_': '/tools/buildbot/bin/python'} 09:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:52 INFO - Running setup.py (path:/tmp/pip-rJlOFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:52 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)) 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:52 INFO - Running setup.py (path:/tmp/pip-VlfLwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:52 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)) 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:52 INFO - Running setup.py (path:/tmp/pip-77x58H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:52 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)) 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:52 INFO - Running setup.py (path:/tmp/pip-ymVtvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:52 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)) 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:52 INFO - Running setup.py (path:/tmp/pip-1deHWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:52 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)) 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:52 INFO - Running setup.py (path:/tmp/pip-e7mubf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:52 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)) 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:52 INFO - Running setup.py (path:/tmp/pip-DwTBZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:52 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)) 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:52 INFO - Running setup.py (path:/tmp/pip-LDsf2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:52 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)) 09:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:52 INFO - Running setup.py (path:/tmp/pip-zl8MNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:53 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)) 09:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:53 INFO - Running setup.py (path:/tmp/pip-S9ubaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:53 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)) 09:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:53 INFO - Running setup.py (path:/tmp/pip-5zCBUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:53 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)) 09:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:53 INFO - Running setup.py (path:/tmp/pip-LTEc3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:53 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)) 09:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:53 INFO - Running setup.py (path:/tmp/pip-IYzZcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:53 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)) 09:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:53 INFO - Running setup.py (path:/tmp/pip-zhwVOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:53 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)) 09:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:53 INFO - Running setup.py (path:/tmp/pip-T0Z9ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:53 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)) 09:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:53 INFO - Running setup.py (path:/tmp/pip-b5OCmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:53 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)) 09:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:53 INFO - Running setup.py (path:/tmp/pip-lgvXfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:53 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)) 09:04:53 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)) 09:04:53 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)) 09:04:53 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)) 09:04:53 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)) 09:04:53 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)) 09:04:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:55 INFO - Downloading blessings-1.6.tar.gz 09:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:55 INFO - Installing collected packages: blessings 09:04:55 INFO - Running setup.py install for blessings 09:04:55 INFO - Successfully installed blessings 09:04:55 INFO - Cleaning up... 09:04:55 INFO - Return code: 0 09:04:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:04:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:55 INFO - Reading from file tmpfile_stdout 09:04:55 INFO - Current package versions: 09:04:55 INFO - argparse == 1.2.1 09:04:55 INFO - blessings == 1.6 09:04:55 INFO - blobuploader == 1.2.4 09:04:55 INFO - docopt == 0.6.1 09:04:55 INFO - manifestparser == 1.1 09:04:55 INFO - mozInstall == 1.12 09:04:55 INFO - mozcrash == 0.17 09:04:55 INFO - mozdebug == 0.1 09:04:55 INFO - mozdevice == 0.48 09:04:55 INFO - mozfile == 1.2 09:04:55 INFO - mozhttpd == 0.7 09:04:55 INFO - mozinfo == 0.9 09:04:55 INFO - mozleak == 0.1 09:04:55 INFO - mozlog == 3.1 09:04:55 INFO - moznetwork == 0.27 09:04:55 INFO - mozprocess == 0.22 09:04:55 INFO - mozprofile == 0.28 09:04:55 INFO - mozrunner == 6.11 09:04:55 INFO - mozscreenshot == 0.1 09:04:55 INFO - mozsystemmonitor == 0.0 09:04:55 INFO - moztest == 0.7 09:04:55 INFO - mozversion == 1.4 09:04:55 INFO - psutil == 3.1.1 09:04:55 INFO - requests == 1.2.3 09:04:55 INFO - wsgiref == 0.1.2 09:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:55 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 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:55 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 09:04:55 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 09:04:55 INFO - Using env: {'DISPLAY': ':0', 09:04:55 INFO - 'HOME': '/home/cltbld', 09:04:55 INFO - 'LANG': 'en_US.UTF-8', 09:04:55 INFO - 'LANGUAGE': 'en_US:en', 09:04:55 INFO - 'LOGNAME': 'cltbld', 09:04:55 INFO - 'MAIL': '/var/mail/cltbld', 09:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:55 INFO - 'MOZ_NO_REMOTE': '1', 09:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:55 INFO - 'NO_EM_RESTART': '1', 09:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:55 INFO - 'PWD': '/builds/slave/test', 09:04:55 INFO - 'SHELL': '/bin/bash', 09:04:55 INFO - 'SHLVL': '1', 09:04:55 INFO - 'TERM': 'linux', 09:04:55 INFO - 'TMOUT': '86400', 09:04:55 INFO - 'USER': 'cltbld', 09:04:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:55 INFO - '_': '/tools/buildbot/bin/python'} 09:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 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)) 09:04:56 INFO - Cleaning up... 09:04:56 INFO - Return code: 0 09:04:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:56 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 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:56 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 09:04:56 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 09:04:56 INFO - Using env: {'DISPLAY': ':0', 09:04:56 INFO - 'HOME': '/home/cltbld', 09:04:56 INFO - 'LANG': 'en_US.UTF-8', 09:04:56 INFO - 'LANGUAGE': 'en_US:en', 09:04:56 INFO - 'LOGNAME': 'cltbld', 09:04:56 INFO - 'MAIL': '/var/mail/cltbld', 09:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:56 INFO - 'MOZ_NO_REMOTE': '1', 09:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:56 INFO - 'NO_EM_RESTART': '1', 09:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:56 INFO - 'PWD': '/builds/slave/test', 09:04:56 INFO - 'SHELL': '/bin/bash', 09:04:56 INFO - 'SHLVL': '1', 09:04:56 INFO - 'TERM': 'linux', 09:04:56 INFO - 'TMOUT': '86400', 09:04:56 INFO - 'USER': 'cltbld', 09:04:56 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:56 INFO - '_': '/tools/buildbot/bin/python'} 09:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:56 INFO - Downloading/unpacking jsonschema 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:58 INFO - Downloading/unpacking functools32 (from jsonschema) 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:58 INFO - warning: no files found matching '*.txt' 09:04:58 INFO - no previously-included directories found matching 'build' 09:04:58 INFO - no previously-included directories found matching 'dist' 09:04:58 INFO - no previously-included directories found matching '.git*' 09:04:58 INFO - Installing collected packages: jsonschema, functools32 09:04:58 INFO - Running setup.py install for functools32 09:04:58 INFO - warning: no files found matching '*.txt' 09:04:58 INFO - no previously-included directories found matching 'build' 09:04:58 INFO - no previously-included directories found matching 'dist' 09:04:58 INFO - no previously-included directories found matching '.git*' 09:04:58 INFO - Successfully installed jsonschema functools32 09:04:58 INFO - Cleaning up... 09:04:58 INFO - Return code: 0 09:04:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc114ad0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c697d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', '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 09:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:04:58 INFO - Using env: {'DISPLAY': ':0', 09:04:58 INFO - 'HOME': '/home/cltbld', 09:04:58 INFO - 'LANG': 'en_US.UTF-8', 09:04:58 INFO - 'LANGUAGE': 'en_US:en', 09:04:58 INFO - 'LOGNAME': 'cltbld', 09:04:58 INFO - 'MAIL': '/var/mail/cltbld', 09:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:58 INFO - 'MOZ_NO_REMOTE': '1', 09:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:58 INFO - 'NO_EM_RESTART': '1', 09:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:58 INFO - 'PWD': '/builds/slave/test', 09:04:58 INFO - 'SHELL': '/bin/bash', 09:04:58 INFO - 'SHLVL': '1', 09:04:58 INFO - 'TERM': 'linux', 09:04:58 INFO - 'TMOUT': '86400', 09:04:58 INFO - 'USER': 'cltbld', 09:04:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:58 INFO - '_': '/tools/buildbot/bin/python'} 09:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:58 INFO - Downloading/unpacking flake8 09:04: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 09:04:59 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 09:04:59 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 09:04:59 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 09:04:59 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 09:04:59 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 09:05:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:05:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:05:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:01 INFO - no previously-included directories found matching 'docs/_build' 09:05:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:05:01 INFO - Running setup.py install for pep8 09:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:01 INFO - no previously-included directories found matching 'docs/_build' 09:05:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:05:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:05:01 INFO - Cleaning up... 09:05:01 INFO - Return code: 0 09:05:01 INFO - Running post-action listener: _resource_record_post_action 09:05:01 INFO - Running post-action listener: _start_resource_monitoring 09:05:01 INFO - Starting resource monitoring. 09:05:01 INFO - ##### 09:05:01 INFO - ##### Running install step. 09:05:01 INFO - ##### 09:05:01 INFO - Running pre-action listener: _resource_record_pre_action 09:05:01 INFO - Running main action method: install 09:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:02 INFO - Reading from file tmpfile_stdout 09:05:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:02 INFO - Reading from file tmpfile_stdout 09:05:02 INFO - Output received: 09:05:02 INFO - Usage: mozinstall [options] installer 09:05:02 INFO - Options: 09:05:02 INFO - -h, --help show this help message and exit 09:05:02 INFO - -d DEST, --destination=DEST 09:05:02 INFO - Directory to install application into. [default: 09:05:02 INFO - "/builds/slave/test"] 09:05:02 INFO - --app=APP Application being installed. [default: firefox] 09:05:02 INFO - mkdir: /builds/slave/test/build/application 09:05:02 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'] 09:05:02 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 09:05:15 INFO - Reading from file tmpfile_stdout 09:05:15 INFO - Output received: 09:05:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:15 INFO - Running post-action listener: _resource_record_post_action 09:05:15 INFO - ##### 09:05:15 INFO - ##### Running run-tests step. 09:05:15 INFO - ##### 09:05:15 INFO - Running pre-action listener: _resource_record_pre_action 09:05:15 INFO - Running main action method: run_tests 09:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:15 INFO - Python 2.7.3 09:05:15 INFO - Return code: 0 09:05:15 INFO - grabbing minidump binary from tooltool 09:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:15 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 0x2cf8640>, '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 0x2cf9540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf99d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:15 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 09:05:15 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 09:05:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:15 INFO - Return code: 0 09:05:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:05:16 INFO - Return code: 0 09:05:16 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/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 09:05:16 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/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 09:05:16 INFO - Using env: {'DISPLAY': ':0', 09:05:16 INFO - 'HOME': '/home/cltbld', 09:05:16 INFO - 'LANG': 'en_US.UTF-8', 09:05:16 INFO - 'LANGUAGE': 'en_US:en', 09:05:16 INFO - 'LOGNAME': 'cltbld', 09:05:16 INFO - 'MAIL': '/var/mail/cltbld', 09:05:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:16 INFO - 'MOZ_NO_REMOTE': '1', 09:05:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:16 INFO - 'NO_EM_RESTART': '1', 09:05:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:16 INFO - 'PWD': '/builds/slave/test', 09:05:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:16 INFO - 'SHELL': '/bin/bash', 09:05:16 INFO - 'SHLVL': '1', 09:05:16 INFO - 'TERM': 'linux', 09:05:16 INFO - 'TMOUT': '86400', 09:05:16 INFO - 'USER': 'cltbld', 09:05:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452', 09:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:16 INFO - '_': '/tools/buildbot/bin/python'} 09:05:16 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/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 09:05:16 INFO - mozversion application_buildid: 20160706061822 09:05:16 INFO - mozversion application_changeset: cda06c358893d526741f3165800d3406111749bc 09:05:16 INFO - mozversion application_display_name: Firefox 09:05:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:16 INFO - mozversion application_name: Firefox 09:05:16 INFO - mozversion application_remotingname: firefox 09:05:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:05:16 INFO - mozversion application_vendor: Mozilla 09:05:16 INFO - mozversion application_version: 48.0 09:05:16 INFO - mozversion platform_buildid: 20160706061822 09:05:16 INFO - mozversion platform_changeset: cda06c358893d526741f3165800d3406111749bc 09:05:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:05:16 INFO - mozversion platform_version: 48.0 09:05:16 INFO - using testdate: 1467821116 09:05:16 INFO - actual date: 1467821116 09:05:16 INFO - starting webserver on 'localhost:54620' 09:05:16 INFO - SUITE-START | Running 2 tests 09:05:16 INFO - TEST-START | dromaeo_css 09:05:16 INFO - operating with platform_type : linux_ 09:05:16 INFO - Initialising browser for dromaeo_css test... 09:05:16 INFO - TEST-INFO | started process 10765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzamnHL/profile http://localhost:54620/getInfo.html) 09:05:20 INFO - PROCESS | 10765 | __metrics Screen width/height:1600/1200 09:05:20 INFO - PROCESS | 10765 | colorDepth:24 09:05:20 INFO - PROCESS | 10765 | Browser inner width/height: 1024/697 09:05:20 INFO - PROCESS | 10765 | __metrics 09:05:21 ERROR - PROCESS | 10765 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:05:22 INFO - TEST-INFO | 10765: exit 0 09:05:22 INFO - Browser initialized. 09:05:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:22 INFO - TEST-INFO | started process 10857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzamnHL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:33 INFO - PROCESS | 10857 | RSS: Main: 138969088 09:05:33 INFO - PROCESS | 10857 | 09:06:24 INFO - PROCESS | 10857 | 1467821184912 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] 09:08:32 INFO - PROCESS | 10857 | Cycle 1(1): loaded http://localhost:54620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54620/tests/dromaeo/cssquery-ext.html) 09:08:33 INFO - PROCESS | 10857 | RSS: Main: 249257984 09:08:33 INFO - PROCESS | 10857 | 09:11:35 INFO - PROCESS | 10857 | Cycle 1(1): loaded http://localhost:54620/tests/dromaeo/cssquery-ext.html (next: http://localhost:54620/tests/dromaeo/cssquery-jquery.html) 09:11:36 INFO - PROCESS | 10857 | RSS: Main: 228925440 09:11:36 INFO - PROCESS | 10857 | 09:14:37 INFO - PROCESS | 10857 | Cycle 1(1): loaded http://localhost:54620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54620/tests/dromaeo/cssquery-mootools.html) 09:14:38 INFO - PROCESS | 10857 | RSS: Main: 219426816 09:14:38 INFO - PROCESS | 10857 | 09:17:40 INFO - PROCESS | 10857 | Cycle 1(1): loaded http://localhost:54620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54620/tests/dromaeo/cssquery-prototype.html) 09:17:40 INFO - PROCESS | 10857 | RSS: Main: 215408640 09:17:40 INFO - PROCESS | 10857 | 09:20:43 INFO - PROCESS | 10857 | Cycle 1(1): loaded http://localhost:54620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54620/tests/dromaeo/cssquery-yui.html) 09:20:43 INFO - PROCESS | 10857 | RSS: Main: 208867328 09:20:43 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | Cycle 1(1): loaded http://localhost:54620/tests/dromaeo/cssquery-yui.html (next: http://localhost:54620/tests/dromaeo/cssquery-dojo.html) 09:23:46 INFO - PROCESS | 10857 | RSS: Main: 252583936 09:23:46 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | __start_tp_report 09:23:46 INFO - PROCESS | 10857 | _x_x_mozilla_page_load 09:23:46 INFO - PROCESS | 10857 | _x_x_mozilla_page_load_details 09:23:46 INFO - PROCESS | 10857 | |i|pagename|runs| 09:23:46 INFO - PROCESS | 10857 | |0;dojo.html;3307.338532293541;3355.39602871483;3358.2108204571928;3392.35545246403;3403.319336132774;5509.72451377431;5522.144067669513;5525.254090697759;5530.640508366963;5535.972320138394;5505.201745746875;5540.2243685883905;5549.1676248562735;5550.084236101038;5589.7205139743055;4927.852164435073;4943.505649435064;4963.3299504566785;5089.516495932899;5131.102057140004;4982.775775090112;5081.339425874631;5081.79672813087;5082.466341034194;5089.872753181163;5018.64869459138;5065.037642847848;5082.872928176788;5100;5100.668456550331;5088.974555127238;5105.5149760772665;5125.256837758541;5125.871853203663;5159.122949098643;4857.417109946829;4944.60443164546;5032.798688052473;5073.949260507385;5082.034413461431;5403.621746477748;5424.891502169974;5426.9185962210595;5436.429174936654;5475.753591088411;5896.469317761379;5932.228810254683;5935.40645935403;5936.643801371932;5938.910916336258;5939.287285525721;5967.7911273105665;5985.790497332572;6023.367546407651;6044.516438684895;5582.162675598652;5583.972080139614;5586.385497595261;5610.999999999959;5646.265985421869;5886;6085.756569737249;6093.969530152321;6099.8475038123515;6099.9085013724825;5759.308882934075;5840.8247752567495;5841.795537156179;5841.94158058414;5855.853603659943;5857.414258574194;5858.47273745365;5860.8534786629825;5861.70691465425;5867.765289388377;5829.271341082364;5833.7083145842535;5834.708264586754;5846.678432686158;5891.3814049525035;5939.643621382731;5945.702714864239;5953.107033944856;5954.672493012839;5988.490978266809;4552.635789136861;4554.954450455453;4555.931661025087;4557.612602928722;4582.243929751554;3995.4606128172327;4029.738067025634;4063.329550624114;4086.693497987663;4119.526254480713;5678.517326027251;5696.23100881384;5701.458361455655;5701.71491425427;5718.370979192286;5967.19442875215;5969.164316995624;5969.253843269591;5975.043992961106;5981.192539007266;5413.945860541423;5634.239377684042;5676.375598684142;5709.9714501427225;5716.256886604715;5049.671771334852;5070.188769796815;5070.771815268322;5071.670341427795;5074.188129899198;6227.719752611143;6229.190205273286;6235.719392627343;6244.937550624436;6245.250569931637;5838.678872661874;5917.142014407973;5964.224650795369;6016.969915150396;6022.608530445507;6263.912874212527;6273.404026617464;6280.842978925563;6318.462930650946;6326.43062124411;5844.094165404369;5892.351841297368;5897.941020589911;5903.350631430453;5933.406659334205;5825.3883342248455;5916.171735956884;5993.9700301498215;6008.519318454601;6035.879282414239;5801.245838041028;5856.267966504187;5860.443257890493;5865.266841644794;5866.354700982974;5690.2887139107615;5794.0439827428;5845.269341332333;5847.356790753099;5850.561207909339;5689;5772;5780.450857168562;5788.247527821356;5801.738921748616;5833.883322333445;5846.298444186725;5847.327557330961;5854.443827836349;5856.970715146567;5535.8892822144135;5593.07714227148;5734.799282025109;5738.196652468741;5760.8271751847515 09:23:46 INFO - PROCESS | 10857 | |1;ext.html;657.2179106862833;669.6306054119325;675.7533500272395;721.6355740351125;736.4771012581069;32008.039758807245;32856.67143328569;40915.79542102293;41806.790966045206;41929.58070419295;44326.77836610821;45027.54972450274;45201;45207.547924520826;45225;8852.380333376666;9037.59330830111;9043.412178208395;9046.457212567235;9047.457152570867;8792.51641159736;8912.821743565157;8917.286617070651;8919.197272245498;8919.73240802777;8908.153725396109;9162.35863489556;9174.770630734252;9181.72454826353;9182.173604375605;9020.233280171193;9073.13805188506;9084.04617515158;9091.999880013227;9092.363534552584;9001.864972025425;9102.044285350075;9105.36262461628;9121.863172052424;9124.908750912473;44449.77775111136;44654;44711.32933006008;45057.098858022655;45168;3854.3062248795204;3963.583823698499;4521.480029796549;4608;4669.649776266793;32749.836250818593;33468.37856355567;33574.664253357645;34773.65226347729;35139.82430087859;3988.5213774346976;4000.659943904772;4043.1711499142607;4121.216968775953;4186.748795072305;321101;323601;323683;323966;325037;39143.80428097841;62268.68865655643;62713;62719;62726;37876.62123378731;37939;37972.24055518874;38061.429078563844;38083.61916380856;17133.828661713473;17243.74134387985;17357.3057077718;17388.565285867702;17394.21726022332;14689.045212061183;14764.187969661556;14774.852251477347;14778.63053423673;14787.482438114614;9138.68014619485;9229.723108306762;9257.120573545637;9282.025387334234;9296.488693121808;3437.2781715839956;3573.94639080414;3595.94606080909;3596.2088340565033;3627.220147668264;1092.6012005617893;1164.85439320085;1180.7461395799944;1226.4848763519344;1296.4101333893057;32795.67204327974;34418.03875420067;34462.48306275408;34583;35231.11922201965;1241.4103300932165;1305.4908585651604;1310.5675127207999;1331.42083193811;1391.1374947532393;17135.314587416615;17958.19188136537;18002.279908803503;18015.099245037694;18079.643542199636;508875;514433;515039;516045;516280;61627.69186154041;63472.682636587444;63692;63737.36262637407;63758.68120659367;1280.3406245783428;1360.115924648986;1377.0498356134235;1533.984660153384;1623.853853153222;23637.64543531814;34041.148971275914;34947.65052349444;35030;35655.28689426249;61078.69460652668;61813.38186618076;61882.69058654678;61930;62022.37977620166;438528;443028;443121;443293;443531;46825.76587117043;46912.06175876395;46982.530174697815;47446.52553474559;47530.28704569365;52396.21405678994;52845.7357713209;53019;53953;54006.729966349914;43276;43304.350434744134;43374.78312608417;44389.485938116515;48771.02457950892;40312.59687403206;41437;41532.792336038125;43134.78432607817;43328.13343733171;38423.04478198911;39171.80414097911;42715.57284427116;43857.78071109624;46614;34779;37380.62619373771;37777;38323.80838095903;38488.6151138485;28806.42387152287;29119.7088029117;29238;29273.406145797875;29506.55740163856 09:23:46 INFO - PROCESS | 10857 | |2;jquery.html;401.2416532753097;414.6226933490523;416.6173044268056;419.4400475365387;426.2498003513817;12886.80669789954;18859.245630174795;19422.320218792345;19425.611487770235;19467.902660486696;15182.468613598527;18098.909505452488;18733.25066997322;19568.51078723029;19873.205071797147;5536.114221724525;5728.341240757304;5731.197632331477;5738.483536481715;5749.108888122348;5634.830955071334;5703.0589952657765;5716.028275193227;5721.456461636138;5722.942770572283;5494.450554944514;5687.800926967557;5701.942980570204;5705.315362156526;5780.161876527901;5801.82594522165;5811.912821307663;5840.2991641003355;5868.823935281948;5869.941300587004;5054.721990290533;5067.746612669352;5224.843254702365;5232.058229518685;5234.581233501311;20119;21210.469738256514;22943.77056229433;23173.53652926932;23326.41683957898;2437.6587277781123;2465.0386349323776;2520.3195137312823;2570.0876188953025;2577.7937764978756;9900.108990190918;9965.15296199824;10266.486675666261;10276.588936442533;10461.947690261575;1994.8104930031623;2010.869293495918;2041.2447394463995;2111.5143516991025;2149.7635260121374;75128.62435687841;77355;77585;80275;82983;10741.40922249268;10880.12958963281;10922.726931826768;11088.778224435466;11113.611023614296;15292.464763733216;15366;15367.462138825087;15373.385064597514;15389;8705.564721763887;8763.868541971875;8830.602622881986;8843.204111629984;8912.955435222782;8422.326213902874;8631.266342360845;8655.48067115975;8837.79055236191;8846.33652476054;4418.425604671436;4810.230363141951;4879.609631229564;4897.363342765418;4942.827001054946;1910.8949007804704;1939.563598190424;1981.51452894039;2060.2377120465526;2107.4099252209407;1114.4761961877905;1115.8549388579595;1123.074391210884;1129.6159305836056;1148.35118158242;18270.45188644343;18341.7248741269;18532.81467185338;18599.259507237315;19157.233710651697;1058.3226734889677;1074.387599068539;1090.5583238788304;1114.7826173896012;1133.4729350851894;10379;10652.946735266274;10679.51942162589;10724.463776811128;10926.672199834018;463316;466775;467560;476887;504084;90469;92339.53830230806;94542.24738024907;94943;95601.04398956061;993.2798720927415;1000.8798944126752;1109.938953357557;1131.0555686002115;1136.3466007045981;16482.34070637209;16574.83425165733;16671.749923751395;16714.58213544671;16939.32242710327;26630.067947622516;27714.584281235395;32826;40713.59286407098;41081.1783764329;55755.44244557503;57275;57493.71253143708;57520.4247957515;57742.7112864433;8614.095519970313;8658.48049117055;8733.257673097858;8864.42381245217;12007.63977080654;8618.569071546523;8849;11127.443627818415;13025.478980841039;13404.530841420503;8027.8795818063945;8099.676012959416;8138.796530086795;8271.586420679063;8577.571121443778;7606.505577137468;7746.65140068687;7829.921700783148;8196.59017049157;8297;7706.961465192639;7774.144844067261;7852.960735196288;7913.327367173624;8611.181937715906;11652.88347116518;11656;12156.93921530422;12334.383280836102;12496.25022498653;11172.385518796544;11208.71978200519;11418.657440276806;11422.31466112036;11852.288862668267 09:23:46 INFO - PROCESS | 10857 | |3;mootools.html;1405.1849927042317;1595.9042457452554;1613.338531202207;1824.4070677029968;1935.5064458563072;7722.613869306533;8395;8601.397902146844;8618.95690521548;8631;8345.749627511184;8517.872231916526;8534.57327133644;8543;8557.52933588654;2347.108098922407;2378.6669866218745;2381.654660074288;2381.9166329178483;2382.857028578282;2300.3444018454743;2325.465143017107;2335.9532809343805;2346.730126035502;2385.153270588942;2222.7777222277723;2224.310463756233;2241.2491815241915;2290.1183044527893;2291.1980806717597;2328.906843726249;2356.45801465663;2368.5144545368244;2368.6210206366986;2390.5935990881594;2346.5424242272766;2358.752331005254;2358.7877091061887;2361.3388251289666;2364.0898254172093;8224.342052635775;8624.439411438236;8801.47191168532;8839.07189745074;8843.292536597057;5132.101882170605;5160.535551800319;5215.791368345262;5218.765155568009;5222.112240919015;3320.7841490303294;3341.4152523308567;3383;3394.4229480988292;3403.6085850127056;1050.8003479338902;1132.750794825137;1139.7435576995192;1151;1161.3554477265116;11865.584704535386;12055.457504412323;12346.259224446472;12347.073969452238;12376.381180941007;4430.889227769267;4520.4575450946095;4597.402337696078;4617.953820461752;4655.092257009851;10681.092107170978;10688.51901664427;10704.946475267574;10711.303765255234;10717.78564428707;5349.893002139936;5352.143657014937;5358.33020872391;5367.1680889462195;5369.033573956725;4132.91734165315;4273.059926816096;4710.36410084641;4820.6143508519235;4902.1176188285735;4116.958830411718;4149.357121007278;4161.542230354658;4165.958340416618;4180.122174343361;1229.237872519026;1261.1172179474222;1261.65935197498;1261.6656586004717;1271.0848189303686;1037.5331101004579;1041.8385150301715;1043.3948309980194;1043.7495001199657;1046.9371837689612;6006.939930600725;6043.7884674036195;6112.052631842072;6112.113743507167;6233.252009758768;455.1988500239536;461.40478782371036;464.13670572734685;464.324407986379;468.4753076554281;4194.454720886265;4243.108947121077;4431.667624928144;4436.689431739747;4474;10768.138548916068;10953.671389858317;10975.615853445091;10993.780124397466;11000.449977501094;9961.850572241423;10743.140548756237;10770.299930504649;10776.946115269373;10793.83809242862;8094.797630059295;8140.837183256302;8148.674053037812;8221.54781487024;8229.917700823034;6001.459868611846;6071.666058366833;6106.267247930276;6209.689515524296;6363.90454143179;9398.67104651334;9518.857217141609;9651.758706032406;9652.565634546603;9666.226701863974;9314.25485961135;9409.435433873989;9587.089226523469;9656.71029869105;9936.105750482491;6895.55178913369;7483.289087536676;7659.770206893802;7694.923050769421;7775.494592851446;8342.040665323566;8348.624311905858;8374.832503349777;8379.413441059067;8413.242808147295;7387.926120738939;7580.166181720117;7616.885746713914;7751.224877512203;7794.805129871572;7623.4663573549315;7625.428092892944;7678.731244406419;7743.341815945708;7758.3017528422715;7020.964895175492;7027.789166325018;7067.469939754436;7074.787756367317;7080.822979425556;4352.717073390219;4516.254817955;4529.909401812011;4552.11233809404;4618.053299073749;5137.280780690631;5183.896322073462;5202.193659982709;5221.164613661796;5261.394939581844 09:23:46 INFO - PROCESS | 10857 | |4;prototype.html;339.23502501858303;345.45073333399887;352.80595672380184;356.4635223987898;360.9693176080033;6046.395360463951;6054.364291749369;6062.333143354227;6073.7266822993015;6077.149199112122;6015.639061656304;6036.09458581213;6041.275046994367;6056.1824153739235;6057.878842423149;4387.1664383767065;4568.634509239269;4680.087382960324;4681.461631912322;4686.086213188412;4631.564215093315;4657.976710116444;4669.579737823595;4670.159371313162;4686.929696054562;4381.780910954455;4639.7680115994235;4640.862988567806;4642.837500687477;4644.210484217691;4500.774961251941;4610.9308360374625;4619.214733495314;4624.7687615619425;4628.3288923105965;4056.675465962716;4060.2691515527194;4070.1859628074503;4071.6131967463043;4075.918481630351;5817.331006934172;5818.796342128047;5828.475437210629;5832.387599302097;5838.124281357788;5345.09133447311;5352.785888564453;5353;5355.036093503168;5369.597280203961;6325.746970121189;6327.24073111225;6332.081848132041;6341.239051313826;6341.365863413668;4257.74453532789;4393.209222339978;4393.275109606911;4396.538363471821;4399.340098985146;6520.152380190592;6594.637294948776;6606.306337834506;6609.140811694497;6610.7355705771715;4439;4441.333799930037;4444.577765112309;4446.244138496463;4449.399331090326;4487.461504619467;4490.528494508095;4498.167838949805;4502.099580083996;4503.617192538671;5204.141316682705;5206.609504287194;5223.451537588575;5224.92162617561;5226.97386513065;6234.127222188898;6378.362163783585;6379.617222966637;6391.872162556723;6393.584417012879;1566.9608259793367;1576.9369225230862;1588.9920550397405;1589.5469791109479;1594.6172918499476;985.5269470654126;1033.612395351743;1034.1003327105466;1052.6421016854154;1081.5403453532217;6111.419415155553;6123.877522449526;6128.080787881764;6160.599561028608;6162.691865406712;6469.223693156851;6483.189601299838;6486.091947127406;6491.221053473613;6495;6141.815745527641;6146.139540464339;6156.815295541141;6166.290876549254;6172.444479996732;3466.913327166841;3499.492573576868;3500.7724497907557;3501.2122272488996;3503.719702423851;6676.132102826601;6733.595984240863;6791.966040169867;6796.25241223465;6801.18385793708;6525.151730275129;6549.279579246279;6568.8357791055605;6576.980568011966;6579.934200657932;6783.491238157059;6788.5926844388505;6794.864102717918;6796.388325050769;6801.1838579369805;6437.452816510462;6466.515011374072;6480.675966201766;6482.546221764431;6485.870282594227;6321.367863213826;6377.7767778127545;6388.425041746265;6551.639659818756;6561.475081993333;6957.826054348682;6989.930100698928;6990.405815505739;6993.650317484004;6995.230524642387;4510.639148868148;4547.977260113678;4549;4549.340345649928;4549.749763762892;6622.271550129385;6622.97999110276;6626.27111017778;6628.966855165693;6633.469322454289;6322.3045464997895;6434.64609446485;6439.839004024937;6442.162518872517;6445.1943507061615;6378.52161087911;6429.132067170872;6429.292777794532;6434.67826608677;6436.16329877113;6310.7791227306825;6320.146780184617;6329.778457753957;6331;6339.334369891095;6458.257300410513;6468.223813142265;6469.870602587827;6485.3514648534765;6491.35086491366;6001.339852616122;6103.3591472894705;6234.127222188988;6315.842103947438;6338.619682819046 09:23:46 INFO - PROCESS | 10857 | |5;yui.html;859.2095272349438;905.5064989580674;912.6896855069275;919.8666193401957;948.1656142594516;14343.713125737479;14354.928225358859;14514.346854391551;14706.191159486223;14725.263736813156;13358.799618005738;13458.259795711232;13482.73034539311;13491.3254337283;13494.190348579092;743.6021728375321;901.4366021236727;923.372106967262;937.8124375125002;942.4109931292942;935.7567032571546;936.7143021378477;938.4041133879967;938.976525586859;939.3049143633696;974.0697633759778;974.7855471796194;975.7170420578059;978.1636700620974;978.4471773448015;771.7530390275115;936.1060187520901;968.162539403418;969.413504829575;982.3909176310661;713.1834050012758;713.4043074033189;713.636045616734;713.6610110197666;713.9214686384494;14038.578842634737;14039.087459315111;14048.85951140496;14085.436582536686;14118;14531.78202326966;14811.777823332659;15161.393544258217;15260.855435842357;15308.770368444482;11697.824532632018;11851.525938962432;12038.578649747216;12285.201461905037;12565.74868502634;4604.194266003436;4636.582707556337;4770.928436073462;4772.7613619319245;4930.556249937487;54881.72559137219;55512;55522.99999999959;55567;55604.72197639026;11600.30398176112;11825.822612660817;12065.215760975509;12478.376081195904;12507.874921250854;21552.461188470414;21552.892235538722;21562;21564.24525141644;21584.568308633738;8439.915600844035;8609.48343099416;8675.696350627697;8716.21554060125;8937.195652391316;4901.892534285407;4981.850544483671;4993.251012348177;5150.4334523202415;5246.737663116829;3534.6111927687934;3559;3590.1024743814046;3595.1191957970464;3596.6762991330384;622.3714048810734;632.5919781740844;633.6736580660963;637.2480473041855;645.9773907913294;679.0425500045012;702.6908160409404;708.2881703887663;788.7002938883303;832.0752554769988;9985.600575977025;10167.186625069977;10177.745556361002;10224.079832815083;10231.181505479544;756.5007095317064;812.7236739508477;829.655692887457;846.9491830490067;848.4781859156574;4583.175028494837;4630.508406845354;4715.5479150841375;4803.807847686054;4828.758562071883;56556;63186.68406657937;63406.365936340044;63428.68285658542;65749;49657.50342496601;50796.23805642918;50893;51054.489455105715;51439.48560514422;45500.77249613797;46094.76952615215;46273;46330.073398531844;48193;9788.314817962675;10010.799784004425;10079.294449388472;10081.344712593658;10192;35447.82276088603;35531.289374211854;36069;36092.63907360998;36613.26773464569;42865.142697146504;45421;45972;46196;47162.52837471581;12110.273383597012;12420.130590858553;12705.428255728699;12746;13152;12857.807132892827;14367.640808979859;14647;15075.472358467401;15122.54632361031;13052.608421747364;13403.32983350848;13920.303984800517;14344.354504047134;14381;13151.53969611059;13250.204987700768;13436.126651767603;13452.730945380841;13583.252921089039;12968.221906685629;13039.739205216032;13219.20684758879;13318.733625327633;13528.797068044185;10917.563297468012;11006.834897476385;11036.392998384845;11287.379194144401;11521.53913843437;11012.39431831257;11114.49984750672;11235.101191904465;11308;11421.543138274708 09:23:46 INFO - PROCESS | 10857 | __end_tp_report 09:23:46 INFO - PROCESS | 10857 | __start_cc_report 09:23:46 INFO - PROCESS | 10857 | _x_x_mozilla_cycle_collect,816 09:23:46 INFO - PROCESS | 10857 | __end_cc_report 09:23:46 INFO - PROCESS | 10857 | __startTimestamp1467822226735__endTimestamp 09:23:46 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | ------- Summary: start ------- 09:23:46 INFO - PROCESS | 10857 | Number of tests: 6 09:23:46 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | [#0] dojo.html Cycles:165 Average:5529.26 Median:5760.83 stddev:618.16 (10.7%) stddev-sans-first:594.97 09:23:46 INFO - PROCESS | 10857 | Values: 3307.3 3355.4 3358.2 3392.4 3403.3 5509.7 5522.1 5525.3 5530.6 5536.0 5505.2 5540.2 5549.2 5550.1 5589.7 4927.9 4943.5 4963.3 5089.5 5131.1 4982.8 5081.3 5081.8 5082.5 5089.9 5018.6 5065.0 5082.9 5100.0 5100.7 5089.0 5105.5 5125.3 5125.9 5159.1 4857.4 4944.6 5032.8 5073.9 5082.0 5403.6 5424.9 5426.9 5436.4 5475.8 5896.5 5932.2 5935.4 5936.6 5938.9 5939.3 5967.8 5985.8 6023.4 6044.5 5582.2 5584.0 5586.4 5611.0 5646.3 5886.0 6085.8 6094.0 6099.8 6099.9 5759.3 5840.8 5841.8 5841.9 5855.9 5857.4 5858.5 5860.9 5861.7 5867.8 5829.3 5833.7 5834.7 5846.7 5891.4 5939.6 5945.7 5953.1 5954.7 5988.5 4552.6 4555.0 4555.9 4557.6 4582.2 3995.5 4029.7 4063.3 4086.7 4119.5 5678.5 5696.2 5701.5 5701.7 5718.4 5967.2 5969.2 5969.3 5975.0 5981.2 5413.9 5634.2 5676.4 5710.0 5716.3 5049.7 5070.2 5070.8 5071.7 5074.2 6227.7 6229.2 6235.7 6244.9 6245.3 5838.7 5917.1 5964.2 6017.0 6022.6 6263.9 6273.4 6280.8 6318.5 6326.4 5844.1 5892.4 5897.9 5903.4 5933.4 5825.4 5916.2 5994.0 6008.5 6035.9 5801.2 5856.3 5860.4 5865.3 5866.4 5690.3 5794.0 5845.3 5847.4 5850.6 5689.0 5772.0 5780.5 5788.2 5801.7 5833.9 5846.3 5847.3 5854.4 5857.0 5535.9 5593.1 5734.8 5738.2 5760.8 09:23:46 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | [#1] ext.html Cycles:180 Average:59610.97 Median:43290.18 stddev:114887.43 (265.4%) stddev-sans-first:115124.45 09:23:46 INFO - PROCESS | 10857 | Values: 657.2 669.6 675.8 721.6 736.5 32008.0 32856.7 40915.8 41806.8 41929.6 44326.8 45027.5 45201.0 45207.5 45225.0 8852.4 9037.6 9043.4 9046.5 9047.5 8792.5 8912.8 8917.3 8919.2 8919.7 8908.2 9162.4 9174.8 9181.7 9182.2 9020.2 9073.1 9084.0 9092.0 9092.4 9001.9 9102.0 9105.4 9121.9 9124.9 44449.8 44654.0 44711.3 45057.1 45168.0 3854.3 3963.6 4521.5 4608.0 4669.6 32749.8 33468.4 33574.7 34773.7 35139.8 3988.5 4000.7 4043.2 4121.2 4186.7 321101.0 323601.0 323683.0 323966.0 325037.0 39143.8 62268.7 62713.0 62719.0 62726.0 37876.6 37939.0 37972.2 38061.4 38083.6 17133.8 17243.7 17357.3 17388.6 17394.2 14689.0 14764.2 14774.9 14778.6 14787.5 9138.7 9229.7 9257.1 9282.0 9296.5 3437.3 3573.9 3595.9 3596.2 3627.2 1092.6 1164.9 1180.7 1226.5 1296.4 32795.7 34418.0 34462.5 34583.0 35231.1 1241.4 1305.5 1310.6 1331.4 1391.1 17135.3 17958.2 18002.3 18015.1 18079.6 508875.0 514433.0 515039.0 516045.0 516280.0 61627.7 63472.7 63692.0 63737.4 63758.7 1280.3 1360.1 1377.0 1534.0 1623.9 23637.6 34041.1 34947.7 35030.0 35655.3 61078.7 61813.4 61882.7 61930.0 62022.4 438528.0 443028.0 443121.0 443293.0 443531.0 46825.8 46912.1 46982.5 47446.5 47530.3 52396.2 52845.7 53019.0 53953.0 54006.7 43276.0 43304.4 43374.8 44389.5 48771.0 40312.6 41437.0 41532.8 43134.8 43328.1 38423.0 39171.8 42715.6 43857.8 46614.0 34779.0 37380.6 37777.0 38323.8 38488.6 28806.4 29119.7 29238.0 29273.4 29506.6 09:23:46 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | [#2] jquery.html Cycles:180 Average:28011.40 Median:40897.39 stddev:78585.00 (192.2%) stddev-sans-first:78778.11 09:23:46 INFO - PROCESS | 10857 | Values: 401.2 414.6 416.6 419.4 426.2 12886.8 18859.2 19422.3 19425.6 19467.9 15182.5 18098.9 18733.3 19568.5 19873.2 5536.1 5728.3 5731.2 5738.5 5749.1 5634.8 5703.1 5716.0 5721.5 5722.9 5494.5 5687.8 5701.9 5705.3 5780.2 5801.8 5811.9 5840.3 5868.8 5869.9 5054.7 5067.7 5224.8 5232.1 5234.6 20119.0 21210.5 22943.8 23173.5 23326.4 2437.7 2465.0 2520.3 2570.1 2577.8 9900.1 9965.2 10266.5 10276.6 10461.9 1994.8 2010.9 2041.2 2111.5 2149.8 75128.6 77355.0 77585.0 80275.0 82983.0 10741.4 10880.1 10922.7 11088.8 11113.6 15292.5 15366.0 15367.5 15373.4 15389.0 8705.6 8763.9 8830.6 8843.2 8913.0 8422.3 8631.3 8655.5 8837.8 8846.3 4418.4 4810.2 4879.6 4897.4 4942.8 1910.9 1939.6 1981.5 2060.2 2107.4 1114.5 1115.9 1123.1 1129.6 1148.4 18270.5 18341.7 18532.8 18599.3 19157.2 1058.3 1074.4 1090.6 1114.8 1133.5 10379.0 10652.9 10679.5 10724.5 10926.7 463316.0 466775.0 467560.0 476887.0 504084.0 90469.0 92339.5 94542.2 94943.0 95601.0 993.3 1000.9 1109.9 1131.1 1136.3 16482.3 16574.8 16671.7 16714.6 16939.3 26630.1 27714.6 32826.0 40713.6 41081.2 55755.4 57275.0 57493.7 57520.4 57742.7 8614.1 8658.5 8733.3 8864.4 12007.6 8618.6 8849.0 11127.4 13025.5 13404.5 8027.9 8099.7 8138.8 8271.6 8577.6 7606.5 7746.7 7829.9 8196.6 8297.0 7707.0 7774.1 7853.0 7913.3 8611.2 11652.9 11656.0 12156.9 12334.4 12496.3 11172.4 11208.7 11418.7 11422.3 11852.3 09:23:46 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | [#3] mootools.html Cycles:180 Average:5731.99 Median:4618.00 stddev:3242.99 (70.2%) stddev-sans-first:3235.78 09:23:46 INFO - PROCESS | 10857 | Values: 1405.2 1595.9 1613.3 1824.4 1935.5 7722.6 8395.0 8601.4 8619.0 8631.0 8345.7 8517.9 8534.6 8543.0 8557.5 2347.1 2378.7 2381.7 2381.9 2382.9 2300.3 2325.5 2336.0 2346.7 2385.2 2222.8 2224.3 2241.2 2290.1 2291.2 2328.9 2356.5 2368.5 2368.6 2390.6 2346.5 2358.8 2358.8 2361.3 2364.1 8224.3 8624.4 8801.5 8839.1 8843.3 5132.1 5160.5 5215.8 5218.8 5222.1 3320.8 3341.4 3383.0 3394.4 3403.6 1050.8 1132.8 1139.7 1151.0 1161.4 11865.6 12055.5 12346.3 12347.1 12376.4 4430.9 4520.5 4597.4 4618.0 4655.1 10681.1 10688.5 10704.9 10711.3 10717.8 5349.9 5352.1 5358.3 5367.2 5369.0 4132.9 4273.1 4710.4 4820.6 4902.1 4117.0 4149.4 4161.5 4166.0 4180.1 1229.2 1261.1 1261.7 1261.7 1271.1 1037.5 1041.8 1043.4 1043.7 1046.9 6006.9 6043.8 6112.1 6112.1 6233.3 455.2 461.4 464.1 464.3 468.5 4194.5 4243.1 4431.7 4436.7 4474.0 10768.1 10953.7 10975.6 10993.8 11000.4 9961.9 10743.1 10770.3 10776.9 10793.8 8094.8 8140.8 8148.7 8221.5 8229.9 6001.5 6071.7 6106.3 6209.7 6363.9 9398.7 9518.9 9651.8 9652.6 9666.2 9314.3 9409.4 9587.1 9656.7 9936.1 6895.6 7483.3 7659.8 7694.9 7775.5 8342.0 8348.6 8374.8 8379.4 8413.2 7387.9 7580.2 7616.9 7751.2 7794.8 7623.5 7625.4 7678.7 7743.3 7758.3 7021.0 7027.8 7067.5 7074.8 7080.8 4352.7 4516.3 4529.9 4552.1 4618.1 5137.3 5183.9 5202.2 5221.2 5261.4 09:23:46 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | [#4] prototype.html Cycles:180 Average:5329.64 Median:6107.39 stddev:1612.40 (26.4%) stddev-sans-first:1572.82 09:23:46 INFO - PROCESS | 10857 | Values: 339.2 345.5 352.8 356.5 361.0 6046.4 6054.4 6062.3 6073.7 6077.1 6015.6 6036.1 6041.3 6056.2 6057.9 4387.2 4568.6 4680.1 4681.5 4686.1 4631.6 4658.0 4669.6 4670.2 4686.9 4381.8 4639.8 4640.9 4642.8 4644.2 4500.8 4610.9 4619.2 4624.8 4628.3 4056.7 4060.3 4070.2 4071.6 4075.9 5817.3 5818.8 5828.5 5832.4 5838.1 5345.1 5352.8 5353.0 5355.0 5369.6 6325.7 6327.2 6332.1 6341.2 6341.4 4257.7 4393.2 4393.3 4396.5 4399.3 6520.2 6594.6 6606.3 6609.1 6610.7 4439.0 4441.3 4444.6 4446.2 4449.4 4487.5 4490.5 4498.2 4502.1 4503.6 5204.1 5206.6 5223.5 5224.9 5227.0 6234.1 6378.4 6379.6 6391.9 6393.6 1567.0 1576.9 1589.0 1589.5 1594.6 985.5 1033.6 1034.1 1052.6 1081.5 6111.4 6123.9 6128.1 6160.6 6162.7 6469.2 6483.2 6486.1 6491.2 6495.0 6141.8 6146.1 6156.8 6166.3 6172.4 3466.9 3499.5 3500.8 3501.2 3503.7 6676.1 6733.6 6792.0 6796.3 6801.2 6525.2 6549.3 6568.8 6577.0 6579.9 6783.5 6788.6 6794.9 6796.4 6801.2 6437.5 6466.5 6480.7 6482.5 6485.9 6321.4 6377.8 6388.4 6551.6 6561.5 6957.8 6989.9 6990.4 6993.7 6995.2 4510.6 4548.0 4549.0 4549.3 4549.7 6622.3 6623.0 6626.3 6629.0 6633.5 6322.3 6434.6 6439.8 6442.2 6445.2 6378.5 6429.1 6429.3 6434.7 6436.2 6310.8 6320.1 6329.8 6331.0 6339.3 6458.3 6468.2 6469.9 6485.4 6491.4 6001.3 6103.4 6234.1 6315.8 6338.6 09:23:46 INFO - PROCESS | 10857 | 09:23:46 INFO - PROCESS | 10857 | [#5] yui.html Cycles:180 Average:15103.78 Median:25041.97 stddev:16697.44 (66.7%) stddev-sans-first:16710.01 09:23:46 INFO - PROCESS | 10857 | Values: 859.2 905.5 912.7 919.9 948.2 14343.7 14354.9 14514.3 14706.2 14725.3 13358.8 13458.3 13482.7 13491.3 13494.2 743.6 901.4 923.4 937.8 942.4 935.8 936.7 938.4 939.0 939.3 974.1 974.8 975.7 978.2 978.4 771.8 936.1 968.2 969.4 982.4 713.2 713.4 713.6 713.7 713.9 14038.6 14039.1 14048.9 14085.4 14118.0 14531.8 14811.8 15161.4 15260.9 15308.8 11697.8 11851.5 12038.6 12285.2 12565.7 4604.2 4636.6 4770.9 4772.8 4930.6 54881.7 55512.0 55523.0 55567.0 55604.7 11600.3 11825.8 12065.2 12478.4 12507.9 21552.5 21552.9 21562.0 21564.2 21584.6 8439.9 8609.5 8675.7 8716.2 8937.2 4901.9 4981.9 4993.3 5150.4 5246.7 3534.6 3559.0 3590.1 3595.1 3596.7 622.4 632.6 633.7 637.2 646.0 679.0 702.7 708.3 788.7 832.1 9985.6 10167.2 10177.7 10224.1 10231.2 756.5 812.7 829.7 846.9 848.5 4583.2 4630.5 4715.5 4803.8 4828.8 56556.0 63186.7 63406.4 63428.7 65749.0 49657.5 50796.2 50893.0 51054.5 51439.5 45500.8 46094.8 46273.0 46330.1 48193.0 9788.3 10010.8 10079.3 10081.3 10192.0 35447.8 35531.3 36069.0 36092.6 36613.3 42865.1 45421.0 45972.0 46196.0 47162.5 12110.3 12420.1 12705.4 12746.0 13152.0 12857.8 14367.6 14647.0 15075.5 15122.5 13052.6 13403.3 13920.3 14344.4 14381.0 13151.5 13250.2 13436.1 13452.7 13583.3 12968.2 13039.7 13219.2 13318.7 13528.8 10917.6 11006.8 11036.4 11287.4 11521.5 11012.4 11114.5 11235.1 11308.0 11421.5 09:23:46 INFO - PROCESS | 10857 | -------- Summary: end -------- 09:23:46 INFO - PROCESS | 10857 | 09:23:47 INFO - TEST-INFO | 10857: exit 0 09:23:47 INFO - TEST-OK | dromaeo_css | took 1110797ms 09:23:47 INFO - TEST-START | kraken 09:23:47 INFO - operating with platform_type : linux_ 09:23:47 INFO - Initialising browser for kraken test... 09:23:47 INFO - TEST-INFO | started process 11052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHBqwCb/profile http://localhost:54620/getInfo.html) 09:23:51 INFO - PROCESS | 11052 | __metrics Screen width/height:1600/1200 09:23:51 INFO - PROCESS | 11052 | colorDepth:24 09:23:51 INFO - PROCESS | 11052 | Browser inner width/height: 1024/697 09:23:51 INFO - PROCESS | 11052 | __metrics 09:23:52 ERROR - PROCESS | 11052 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:23:52 INFO - TEST-INFO | 11052: exit 0 09:23:52 INFO - Browser initialized. 09:23:52 INFO - Running cycle 1/1 for kraken test... 09:23:52 INFO - TEST-INFO | started process 11147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHBqwCb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:04 INFO - PROCESS | 11147 | RSS: Main: 139554816 09:24:04 INFO - PROCESS | 11147 | 09:24:07 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54620/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:07 INFO - PROCESS | 11147 | RSS: Main: 198066176 09:24:07 INFO - PROCESS | 11147 | 09:24:10 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54620/tests/kraken/driver.html?testName=audio-dft) 09:24:11 INFO - PROCESS | 11147 | RSS: Main: 184397824 09:24:11 INFO - PROCESS | 11147 | 09:24:13 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54620/tests/kraken/driver.html?testName=audio-fft) 09:24:14 INFO - PROCESS | 11147 | RSS: Main: 273199104 09:24:14 INFO - PROCESS | 11147 | 09:24:16 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54620/tests/kraken/driver.html?testName=audio-oscillator) 09:24:17 INFO - PROCESS | 11147 | RSS: Main: 179519488 09:24:17 INFO - PROCESS | 11147 | 09:24:19 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:19 INFO - PROCESS | 11147 | RSS: Main: 177758208 09:24:19 INFO - PROCESS | 11147 | 09:24:22 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54620/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:23 INFO - PROCESS | 11147 | RSS: Main: 212410368 09:24:23 INFO - PROCESS | 11147 | 09:24:26 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54620/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:27 INFO - PROCESS | 11147 | RSS: Main: 212140032 09:24:27 INFO - PROCESS | 11147 | 09:24:30 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54620/tests/kraken/driver.html?testName=json-parse-financial) 09:24:30 INFO - PROCESS | 11147 | RSS: Main: 212074496 09:24:30 INFO - PROCESS | 11147 | 09:24:32 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:32 INFO - PROCESS | 11147 | RSS: Main: 192880640 09:24:32 INFO - PROCESS | 11147 | 09:24:34 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54620/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:35 INFO - PROCESS | 11147 | RSS: Main: 195940352 09:24:35 INFO - PROCESS | 11147 | 09:24:37 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:37 INFO - PROCESS | 11147 | RSS: Main: 208941056 09:24:37 INFO - PROCESS | 11147 | 09:24:40 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:40 INFO - PROCESS | 11147 | RSS: Main: 218148864 09:24:40 INFO - PROCESS | 11147 | 09:24:43 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:44 INFO - PROCESS | 11147 | RSS: Main: 212332544 09:24:44 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | Cycle 1(1): loaded http://localhost:54620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54620/tests/kraken/driver.html?testName=ai-astar) 09:24:45 INFO - PROCESS | 11147 | RSS: Main: 273825792 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | __start_tp_report 09:24:45 INFO - PROCESS | 11147 | _x_x_mozilla_page_load 09:24:45 INFO - PROCESS | 11147 | _x_x_mozilla_page_load_details 09:24:45 INFO - PROCESS | 11147 | |i|pagename|runs| 09:24:45 INFO - PROCESS | 11147 | |0;ai-astar;109;109;109;109;109;112;105;109;109;109 09:24:45 INFO - PROCESS | 11147 | |1;audio-beat-detection;152;125;157;183;131;154;163;129;191;126 09:24:45 INFO - PROCESS | 11147 | |2;audio-dft;161;162;161;160;160;161;160;160;161;159 09:24:45 INFO - PROCESS | 11147 | |3;audio-fft;77;74;76;175;74;76;74;74;174;74 09:24:45 INFO - PROCESS | 11147 | |4;audio-oscillator;93;93;157;93;92;91;142;92;92;154 09:24:45 INFO - PROCESS | 11147 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 09:24:45 INFO - PROCESS | 11147 | |6;imaging-darkroom;145;146;146;146;146;145;145;146;145;145 09:24:45 INFO - PROCESS | 11147 | |7;imaging-desaturate;95;94;95;94;95;94;94;94;94;95 09:24:45 INFO - PROCESS | 11147 | |8;json-parse-financial;56;54;54;55;55;54;57;75;52;53 09:24:45 INFO - PROCESS | 11147 | |9;json-stringify-tinderbox;57;57;59;58;58;57;58;58;58;58 09:24:45 INFO - PROCESS | 11147 | |10;stanford-crypto-aes;72;71;79;72;73;82;80;73;72;80 09:24:45 INFO - PROCESS | 11147 | |11;stanford-crypto-ccm;122;115;120;122;111;112;114;117;128;115 09:24:45 INFO - PROCESS | 11147 | |12;stanford-crypto-pbkdf2;163;164;167;161;168;161;159;161;159;160 09:24:45 INFO - PROCESS | 11147 | |13;stanford-crypto-sha256-iterative;69;68;70;66;66;66;66;67;66;69 09:24:45 INFO - PROCESS | 11147 | __end_tp_report 09:24:45 INFO - PROCESS | 11147 | __start_cc_report 09:24:45 INFO - PROCESS | 11147 | _x_x_mozilla_cycle_collect,1590 09:24:45 INFO - PROCESS | 11147 | __end_cc_report 09:24:45 INFO - PROCESS | 11147 | __startTimestamp1467822285966__endTimestamp 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | ------- Summary: start ------- 09:24:45 INFO - PROCESS | 11147 | Number of tests: 14 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:1.66 (1.5%) stddev-sans-first:1.76 09:24:45 INFO - PROCESS | 11147 | Values: 109.0 109.0 109.0 109.0 109.0 112.0 105.0 109.0 109.0 109.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:155.50 stddev:23.57 (15.2%) stddev-sans-first:24.99 09:24:45 INFO - PROCESS | 11147 | Values: 152.0 125.0 157.0 183.0 131.0 154.0 163.0 129.0 191.0 126.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 09:24:45 INFO - PROCESS | 11147 | Values: 161.0 162.0 161.0 160.0 160.0 161.0 160.0 160.0 161.0 159.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#3] audio-fft Cycles:10 Average:94.80 Median:74.00 stddev:42.02 (56.8%) stddev-sans-first:44.07 09:24:45 INFO - PROCESS | 11147 | Values: 77.0 74.0 76.0 175.0 74.0 76.0 74.0 74.0 174.0 74.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:28.61 (31.1%) stddev-sans-first:29.69 09:24:45 INFO - PROCESS | 11147 | Values: 93.0 93.0 157.0 93.0 92.0 91.0 142.0 92.0 92.0 154.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:24:45 INFO - PROCESS | 11147 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:24:45 INFO - PROCESS | 11147 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:24:45 INFO - PROCESS | 11147 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.00 stddev:6.65 (12.1%) stddev-sans-first:7.06 09:24:45 INFO - PROCESS | 11147 | Values: 56.0 54.0 54.0 55.0 55.0 54.0 57.0 75.0 52.0 53.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 09:24:45 INFO - PROCESS | 11147 | Values: 57.0 57.0 59.0 58.0 58.0 57.0 58.0 58.0 58.0 58.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:76.00 stddev:4.27 (5.6%) stddev-sans-first:4.35 09:24:45 INFO - PROCESS | 11147 | Values: 72.0 71.0 79.0 72.0 73.0 82.0 80.0 73.0 72.0 80.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:118.50 stddev:5.32 (4.5%) stddev-sans-first:5.40 09:24:45 INFO - PROCESS | 11147 | Values: 122.0 115.0 120.0 122.0 111.0 112.0 114.0 117.0 128.0 115.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.00 stddev:3.16 (2.0%) stddev-sans-first:3.35 09:24:45 INFO - PROCESS | 11147 | Values: 163.0 164.0 167.0 161.0 168.0 161.0 159.0 161.0 159.0 160.0 09:24:45 INFO - PROCESS | 11147 | 09:24:45 INFO - PROCESS | 11147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.57 (2.3%) stddev-sans-first:1.54 09:24:45 INFO - PROCESS | 11147 | Values: 69.0 68.0 70.0 66.0 66.0 66.0 66.0 67.0 66.0 69.0 09:24:45 INFO - PROCESS | 11147 | -------- Summary: end -------- 09:24:45 INFO - PROCESS | 11147 | 09:24:46 INFO - TEST-INFO | 11147: exit 0 09:24:46 INFO - TEST-OK | kraken | took 59441ms 09:24:46 INFO - SUITE-END | took 1170s 09:24:47 INFO - Completed test suite (00:19:30) 09:24:47 INFO - javascript benchmark 09:24:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.338532293541, 3355.39602871483, 3358.2108204571928, 3392.35545246403, 3403.319336132774, 5509.72451377431, 5522.144067669513, 5525.254090697759, 5530.640508366963, 5535.972320138394, 5505.201745746875, 5540.2243685883905, 5549.1676248562735, 5550.084236101038, 5589.7205139743055, 4927.852164435073, 4943.505649435064, 4963.3299504566785, 5089.516495932899, 5131.102057140004, 4982.775775090112, 5081.339425874631, 5081.79672813087, 5082.466341034194, 5089.872753181163, 5018.64869459138, 5065.037642847848, 5082.872928176788, 5100.0, 5100.668456550331, 5088.974555127238, 5105.5149760772665, 5125.256837758541, 5125.871853203663, 5159.122949098643, 4857.417109946829, 4944.60443164546, 5032.798688052473, 5073.949260507385, 5082.034413461431, 5403.621746477748, 5424.891502169974, 5426.9185962210595, 5436.429174936654, 5475.753591088411, 5896.469317761379, 5932.228810254683, 5935.40645935403, 5936.643801371932, 5938.910916336258, 5939.287285525721, 5967.7911273105665, 5985.790497332572, 6023.367546407651, 6044.516438684895, 5582.162675598652, 5583.972080139614, 5586.385497595261, 5610.999999999959, 5646.265985421869, 5886.0, 6085.756569737249, 6093.969530152321, 6099.8475038123515, 6099.9085013724825, 5759.308882934075, 5840.8247752567495, 5841.795537156179, 5841.94158058414, 5855.853603659943, 5857.414258574194, 5858.47273745365, 5860.8534786629825, 5861.70691465425, 5867.765289388377, 5829.271341082364, 5833.7083145842535, 5834.708264586754, 5846.678432686158, 5891.3814049525035, 5939.643621382731, 5945.702714864239, 5953.107033944856, 5954.672493012839, 5988.490978266809, 4552.635789136861, 4554.954450455453, 4555.931661025087, 4557.612602928722, 4582.243929751554, 3995.4606128172327, 4029.738067025634, 4063.329550624114, 4086.693497987663, 4119.526254480713, 5678.517326027251, 5696.23100881384, 5701.458361455655, 5701.71491425427, 5718.370979192286, 5967.19442875215, 5969.164316995624, 5969.253843269591, 5975.043992961106, 5981.192539007266, 5413.945860541423, 5634.239377684042, 5676.375598684142, 5709.9714501427225, 5716.256886604715, 5049.671771334852, 5070.188769796815, 5070.771815268322, 5071.670341427795, 5074.188129899198, 6227.719752611143, 6229.190205273286, 6235.719392627343, 6244.937550624436, 6245.250569931637, 5838.678872661874, 5917.142014407973, 5964.224650795369, 6016.969915150396, 6022.608530445507, 6263.912874212527, 6273.404026617464, 6280.842978925563, 6318.462930650946, 6326.43062124411, 5844.094165404369, 5892.351841297368, 5897.941020589911, 5903.350631430453, 5933.406659334205, 5825.3883342248455, 5916.171735956884, 5993.9700301498215, 6008.519318454601, 6035.879282414239, 5801.245838041028, 5856.267966504187, 5860.443257890493, 5865.266841644794, 5866.354700982974, 5690.2887139107615, 5794.0439827428, 5845.269341332333, 5847.356790753099, 5850.561207909339, 5689.0, 5772.0, 5780.450857168562, 5788.247527821356, 5801.738921748616, 5833.883322333445, 5846.298444186725, 5847.327557330961, 5854.443827836349, 5856.970715146567, 5535.8892822144135, 5593.07714227148, 5734.799282025109, 5738.196652468741, 5760.8271751847515], "value": 5489.084634663286, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.2179106862833, 669.6306054119325, 675.7533500272395, 721.6355740351125, 736.4771012581069, 32008.039758807245, 32856.67143328569, 40915.79542102293, 41806.790966045206, 41929.58070419295, 44326.77836610821, 45027.54972450274, 45201.0, 45207.547924520826, 45225.0, 8852.380333376666, 9037.59330830111, 9043.412178208395, 9046.457212567235, 9047.457152570867, 8792.51641159736, 8912.821743565157, 8917.286617070651, 8919.197272245498, 8919.73240802777, 8908.153725396109, 9162.35863489556, 9174.770630734252, 9181.72454826353, 9182.173604375605, 9020.233280171193, 9073.13805188506, 9084.04617515158, 9091.999880013227, 9092.363534552584, 9001.864972025425, 9102.044285350075, 9105.36262461628, 9121.863172052424, 9124.908750912473, 44449.77775111136, 44654.0, 44711.32933006008, 45057.098858022655, 45168.0, 3854.3062248795204, 3963.583823698499, 4521.480029796549, 4608.0, 4669.649776266793, 32749.836250818593, 33468.37856355567, 33574.664253357645, 34773.65226347729, 35139.82430087859, 3988.5213774346976, 4000.659943904772, 4043.1711499142607, 4121.216968775953, 4186.748795072305, 321101.0, 323601.0, 323683.0, 323966.0, 325037.0, 39143.80428097841, 62268.68865655643, 62713.0, 62719.0, 62726.0, 37876.62123378731, 37939.0, 37972.24055518874, 38061.429078563844, 38083.61916380856, 17133.828661713473, 17243.74134387985, 17357.3057077718, 17388.565285867702, 17394.21726022332, 14689.045212061183, 14764.187969661556, 14774.852251477347, 14778.63053423673, 14787.482438114614, 9138.68014619485, 9229.723108306762, 9257.120573545637, 9282.025387334234, 9296.488693121808, 3437.2781715839956, 3573.94639080414, 3595.94606080909, 3596.2088340565033, 3627.220147668264, 1092.6012005617893, 1164.85439320085, 1180.7461395799944, 1226.4848763519344, 1296.4101333893057, 32795.67204327974, 34418.03875420067, 34462.48306275408, 34583.0, 35231.11922201965, 1241.4103300932165, 1305.4908585651604, 1310.5675127207999, 1331.42083193811, 1391.1374947532393, 17135.314587416615, 17958.19188136537, 18002.279908803503, 18015.099245037694, 18079.643542199636, 508875.0, 514433.0, 515039.0, 516045.0, 516280.0, 61627.69186154041, 63472.682636587444, 63692.0, 63737.36262637407, 63758.68120659367, 1280.3406245783428, 1360.115924648986, 1377.0498356134235, 1533.984660153384, 1623.853853153222, 23637.64543531814, 34041.148971275914, 34947.65052349444, 35030.0, 35655.28689426249, 61078.69460652668, 61813.38186618076, 61882.69058654678, 61930.0, 62022.37977620166, 438528.0, 443028.0, 443121.0, 443293.0, 443531.0, 46825.76587117043, 46912.06175876395, 46982.530174697815, 47446.52553474559, 47530.28704569365, 52396.21405678994, 52845.7357713209, 53019.0, 53953.0, 54006.729966349914, 43276.0, 43304.350434744134, 43374.78312608417, 44389.485938116515, 48771.02457950892, 40312.59687403206, 41437.0, 41532.792336038125, 43134.78432607817, 43328.13343733171, 38423.04478198911, 39171.80414097911, 42715.57284427116, 43857.78071109624, 46614.0, 34779.0, 37380.62619373771, 37777.0, 38323.80838095903, 38488.6151138485, 28806.42387152287, 29119.7088029117, 29238.0, 29273.406145797875, 29506.55740163856], "value": 20202.20076335013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.2416532753097, 414.6226933490523, 416.6173044268056, 419.4400475365387, 426.2498003513817, 12886.80669789954, 18859.245630174795, 19422.320218792345, 19425.611487770235, 19467.902660486696, 15182.468613598527, 18098.909505452488, 18733.25066997322, 19568.51078723029, 19873.205071797147, 5536.114221724525, 5728.341240757304, 5731.197632331477, 5738.483536481715, 5749.108888122348, 5634.830955071334, 5703.0589952657765, 5716.028275193227, 5721.456461636138, 5722.942770572283, 5494.450554944514, 5687.800926967557, 5701.942980570204, 5705.315362156526, 5780.161876527901, 5801.82594522165, 5811.912821307663, 5840.2991641003355, 5868.823935281948, 5869.941300587004, 5054.721990290533, 5067.746612669352, 5224.843254702365, 5232.058229518685, 5234.581233501311, 20119.0, 21210.469738256514, 22943.77056229433, 23173.53652926932, 23326.41683957898, 2437.6587277781123, 2465.0386349323776, 2520.3195137312823, 2570.0876188953025, 2577.7937764978756, 9900.108990190918, 9965.15296199824, 10266.486675666261, 10276.588936442533, 10461.947690261575, 1994.8104930031623, 2010.869293495918, 2041.2447394463995, 2111.5143516991025, 2149.7635260121374, 75128.62435687841, 77355.0, 77585.0, 80275.0, 82983.0, 10741.40922249268, 10880.12958963281, 10922.726931826768, 11088.778224435466, 11113.611023614296, 15292.464763733216, 15366.0, 15367.462138825087, 15373.385064597514, 15389.0, 8705.564721763887, 8763.868541971875, 8830.602622881986, 8843.204111629984, 8912.955435222782, 8422.326213902874, 8631.266342360845, 8655.48067115975, 8837.79055236191, 8846.33652476054, 4418.425604671436, 4810.230363141951, 4879.609631229564, 4897.363342765418, 4942.827001054946, 1910.8949007804704, 1939.563598190424, 1981.51452894039, 2060.2377120465526, 2107.4099252209407, 1114.4761961877905, 1115.8549388579595, 1123.074391210884, 1129.6159305836056, 1148.35118158242, 18270.45188644343, 18341.7248741269, 18532.81467185338, 18599.259507237315, 19157.233710651697, 1058.3226734889677, 1074.387599068539, 1090.5583238788304, 1114.7826173896012, 1133.4729350851894, 10379.0, 10652.946735266274, 10679.51942162589, 10724.463776811128, 10926.672199834018, 463316.0, 466775.0, 467560.0, 476887.0, 504084.0, 90469.0, 92339.53830230806, 94542.24738024907, 94943.0, 95601.04398956061, 993.2798720927415, 1000.8798944126752, 1109.938953357557, 1131.0555686002115, 1136.3466007045981, 16482.34070637209, 16574.83425165733, 16671.749923751395, 16714.58213544671, 16939.32242710327, 26630.067947622516, 27714.584281235395, 32826.0, 40713.59286407098, 41081.1783764329, 55755.44244557503, 57275.0, 57493.71253143708, 57520.4247957515, 57742.7112864433, 8614.095519970313, 8658.48049117055, 8733.257673097858, 8864.42381245217, 12007.63977080654, 8618.569071546523, 8849.0, 11127.443627818415, 13025.478980841039, 13404.530841420503, 8027.8795818063945, 8099.676012959416, 8138.796530086795, 8271.586420679063, 8577.571121443778, 7606.505577137468, 7746.65140068687, 7829.921700783148, 8196.59017049157, 8297.0, 7706.961465192639, 7774.144844067261, 7852.960735196288, 7913.327367173624, 8611.181937715906, 11652.88347116518, 11656.0, 12156.93921530422, 12334.383280836102, 12496.25022498653, 11172.385518796544, 11208.71978200519, 11418.657440276806, 11422.31466112036, 11852.288862668267], "value": 9016.60030702739, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.1849927042317, 1595.9042457452554, 1613.338531202207, 1824.4070677029968, 1935.5064458563072, 7722.613869306533, 8395.0, 8601.397902146844, 8618.95690521548, 8631.0, 8345.749627511184, 8517.872231916526, 8534.57327133644, 8543.0, 8557.52933588654, 2347.108098922407, 2378.6669866218745, 2381.654660074288, 2381.9166329178483, 2382.857028578282, 2300.3444018454743, 2325.465143017107, 2335.9532809343805, 2346.730126035502, 2385.153270588942, 2222.7777222277723, 2224.310463756233, 2241.2491815241915, 2290.1183044527893, 2291.1980806717597, 2328.906843726249, 2356.45801465663, 2368.5144545368244, 2368.6210206366986, 2390.5935990881594, 2346.5424242272766, 2358.752331005254, 2358.7877091061887, 2361.3388251289666, 2364.0898254172093, 8224.342052635775, 8624.439411438236, 8801.47191168532, 8839.07189745074, 8843.292536597057, 5132.101882170605, 5160.535551800319, 5215.791368345262, 5218.765155568009, 5222.112240919015, 3320.7841490303294, 3341.4152523308567, 3383.0, 3394.4229480988292, 3403.6085850127056, 1050.8003479338902, 1132.750794825137, 1139.7435576995192, 1151.0, 1161.3554477265116, 11865.584704535386, 12055.457504412323, 12346.259224446472, 12347.073969452238, 12376.381180941007, 4430.889227769267, 4520.4575450946095, 4597.402337696078, 4617.953820461752, 4655.092257009851, 10681.092107170978, 10688.51901664427, 10704.946475267574, 10711.303765255234, 10717.78564428707, 5349.893002139936, 5352.143657014937, 5358.33020872391, 5367.1680889462195, 5369.033573956725, 4132.91734165315, 4273.059926816096, 4710.36410084641, 4820.6143508519235, 4902.1176188285735, 4116.958830411718, 4149.357121007278, 4161.542230354658, 4165.958340416618, 4180.122174343361, 1229.237872519026, 1261.1172179474222, 1261.65935197498, 1261.6656586004717, 1271.0848189303686, 1037.5331101004579, 1041.8385150301715, 1043.3948309980194, 1043.7495001199657, 1046.9371837689612, 6006.939930600725, 6043.7884674036195, 6112.052631842072, 6112.113743507167, 6233.252009758768, 455.1988500239536, 461.40478782371036, 464.13670572734685, 464.324407986379, 468.4753076554281, 4194.454720886265, 4243.108947121077, 4431.667624928144, 4436.689431739747, 4474.0, 10768.138548916068, 10953.671389858317, 10975.615853445091, 10993.780124397466, 11000.449977501094, 9961.850572241423, 10743.140548756237, 10770.299930504649, 10776.946115269373, 10793.83809242862, 8094.797630059295, 8140.837183256302, 8148.674053037812, 8221.54781487024, 8229.917700823034, 6001.459868611846, 6071.666058366833, 6106.267247930276, 6209.689515524296, 6363.90454143179, 9398.67104651334, 9518.857217141609, 9651.758706032406, 9652.565634546603, 9666.226701863974, 9314.25485961135, 9409.435433873989, 9587.089226523469, 9656.71029869105, 9936.105750482491, 6895.55178913369, 7483.289087536676, 7659.770206893802, 7694.923050769421, 7775.494592851446, 8342.040665323566, 8348.624311905858, 8374.832503349777, 8379.413441059067, 8413.242808147295, 7387.926120738939, 7580.166181720117, 7616.885746713914, 7751.224877512203, 7794.805129871572, 7623.4663573549315, 7625.428092892944, 7678.731244406419, 7743.341815945708, 7758.3017528422715, 7020.964895175492, 7027.789166325018, 7067.469939754436, 7074.787756367317, 7080.822979425556, 4352.717073390219, 4516.254817955, 4529.909401812011, 4552.11233809404, 4618.053299073749, 5137.280780690631, 5183.896322073462, 5202.193659982709, 5221.164613661796, 5261.394939581844], "value": 4541.123558899372, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.23502501858303, 345.45073333399887, 352.80595672380184, 356.4635223987898, 360.9693176080033, 6046.395360463951, 6054.364291749369, 6062.333143354227, 6073.7266822993015, 6077.149199112122, 6015.639061656304, 6036.09458581213, 6041.275046994367, 6056.1824153739235, 6057.878842423149, 4387.1664383767065, 4568.634509239269, 4680.087382960324, 4681.461631912322, 4686.086213188412, 4631.564215093315, 4657.976710116444, 4669.579737823595, 4670.159371313162, 4686.929696054562, 4381.780910954455, 4639.7680115994235, 4640.862988567806, 4642.837500687477, 4644.210484217691, 4500.774961251941, 4610.9308360374625, 4619.214733495314, 4624.7687615619425, 4628.3288923105965, 4056.675465962716, 4060.2691515527194, 4070.1859628074503, 4071.6131967463043, 4075.918481630351, 5817.331006934172, 5818.796342128047, 5828.475437210629, 5832.387599302097, 5838.124281357788, 5345.09133447311, 5352.785888564453, 5353.0, 5355.036093503168, 5369.597280203961, 6325.746970121189, 6327.24073111225, 6332.081848132041, 6341.239051313826, 6341.365863413668, 4257.74453532789, 4393.209222339978, 4393.275109606911, 4396.538363471821, 4399.340098985146, 6520.152380190592, 6594.637294948776, 6606.306337834506, 6609.140811694497, 6610.7355705771715, 4439.0, 4441.333799930037, 4444.577765112309, 4446.244138496463, 4449.399331090326, 4487.461504619467, 4490.528494508095, 4498.167838949805, 4502.099580083996, 4503.617192538671, 5204.141316682705, 5206.609504287194, 5223.451537588575, 5224.92162617561, 5226.97386513065, 6234.127222188898, 6378.362163783585, 6379.617222966637, 6391.872162556723, 6393.584417012879, 1566.9608259793367, 1576.9369225230862, 1588.9920550397405, 1589.5469791109479, 1594.6172918499476, 985.5269470654126, 1033.612395351743, 1034.1003327105466, 1052.6421016854154, 1081.5403453532217, 6111.419415155553, 6123.877522449526, 6128.080787881764, 6160.599561028608, 6162.691865406712, 6469.223693156851, 6483.189601299838, 6486.091947127406, 6491.221053473613, 6495.0, 6141.815745527641, 6146.139540464339, 6156.815295541141, 6166.290876549254, 6172.444479996732, 3466.913327166841, 3499.492573576868, 3500.7724497907557, 3501.2122272488996, 3503.719702423851, 6676.132102826601, 6733.595984240863, 6791.966040169867, 6796.25241223465, 6801.18385793708, 6525.151730275129, 6549.279579246279, 6568.8357791055605, 6576.980568011966, 6579.934200657932, 6783.491238157059, 6788.5926844388505, 6794.864102717918, 6796.388325050769, 6801.1838579369805, 6437.452816510462, 6466.515011374072, 6480.675966201766, 6482.546221764431, 6485.870282594227, 6321.367863213826, 6377.7767778127545, 6388.425041746265, 6551.639659818756, 6561.475081993333, 6957.826054348682, 6989.930100698928, 6990.405815505739, 6993.650317484004, 6995.230524642387, 4510.639148868148, 4547.977260113678, 4549.0, 4549.340345649928, 4549.749763762892, 6622.271550129385, 6622.97999110276, 6626.27111017778, 6628.966855165693, 6633.469322454289, 6322.3045464997895, 6434.64609446485, 6439.839004024937, 6442.162518872517, 6445.1943507061615, 6378.52161087911, 6429.132067170872, 6429.292777794532, 6434.67826608677, 6436.16329877113, 6310.7791227306825, 6320.146780184617, 6329.778457753957, 6331.0, 6339.334369891095, 6458.257300410513, 6468.223813142265, 6469.870602587827, 6485.3514648534765, 6491.35086491366, 6001.339852616122, 6103.3591472894705, 6234.127222188988, 6315.842103947438, 6338.619682819046], "value": 4804.939376067607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.2095272349438, 905.5064989580674, 912.6896855069275, 919.8666193401957, 948.1656142594516, 14343.713125737479, 14354.928225358859, 14514.346854391551, 14706.191159486223, 14725.263736813156, 13358.799618005738, 13458.259795711232, 13482.73034539311, 13491.3254337283, 13494.190348579092, 743.6021728375321, 901.4366021236727, 923.372106967262, 937.8124375125002, 942.4109931292942, 935.7567032571546, 936.7143021378477, 938.4041133879967, 938.976525586859, 939.3049143633696, 974.0697633759778, 974.7855471796194, 975.7170420578059, 978.1636700620974, 978.4471773448015, 771.7530390275115, 936.1060187520901, 968.162539403418, 969.413504829575, 982.3909176310661, 713.1834050012758, 713.4043074033189, 713.636045616734, 713.6610110197666, 713.9214686384494, 14038.578842634737, 14039.087459315111, 14048.85951140496, 14085.436582536686, 14118.0, 14531.78202326966, 14811.777823332659, 15161.393544258217, 15260.855435842357, 15308.770368444482, 11697.824532632018, 11851.525938962432, 12038.578649747216, 12285.201461905037, 12565.74868502634, 4604.194266003436, 4636.582707556337, 4770.928436073462, 4772.7613619319245, 4930.556249937487, 54881.72559137219, 55512.0, 55522.99999999959, 55567.0, 55604.72197639026, 11600.30398176112, 11825.822612660817, 12065.215760975509, 12478.376081195904, 12507.874921250854, 21552.461188470414, 21552.892235538722, 21562.0, 21564.24525141644, 21584.568308633738, 8439.915600844035, 8609.48343099416, 8675.696350627697, 8716.21554060125, 8937.195652391316, 4901.892534285407, 4981.850544483671, 4993.251012348177, 5150.4334523202415, 5246.737663116829, 3534.6111927687934, 3559.0, 3590.1024743814046, 3595.1191957970464, 3596.6762991330384, 622.3714048810734, 632.5919781740844, 633.6736580660963, 637.2480473041855, 645.9773907913294, 679.0425500045012, 702.6908160409404, 708.2881703887663, 788.7002938883303, 832.0752554769988, 9985.600575977025, 10167.186625069977, 10177.745556361002, 10224.079832815083, 10231.181505479544, 756.5007095317064, 812.7236739508477, 829.655692887457, 846.9491830490067, 848.4781859156574, 4583.175028494837, 4630.508406845354, 4715.5479150841375, 4803.807847686054, 4828.758562071883, 56556.0, 63186.68406657937, 63406.365936340044, 63428.68285658542, 65749.0, 49657.50342496601, 50796.23805642918, 50893.0, 51054.489455105715, 51439.48560514422, 45500.77249613797, 46094.76952615215, 46273.0, 46330.073398531844, 48193.0, 9788.314817962675, 10010.799784004425, 10079.294449388472, 10081.344712593658, 10192.0, 35447.82276088603, 35531.289374211854, 36069.0, 36092.63907360998, 36613.26773464569, 42865.142697146504, 45421.0, 45972.0, 46196.0, 47162.52837471581, 12110.273383597012, 12420.130590858553, 12705.428255728699, 12746.0, 13152.0, 12857.807132892827, 14367.640808979859, 14647.0, 15075.472358467401, 15122.54632361031, 13052.608421747364, 13403.32983350848, 13920.303984800517, 14344.354504047134, 14381.0, 13151.53969611059, 13250.204987700768, 13436.126651767603, 13452.730945380841, 13583.252921089039, 12968.221906685629, 13039.739205216032, 13219.20684758879, 13318.733625327633, 13528.797068044185, 10917.563297468012, 11006.834897476385, 11036.392998384845, 11287.379194144401, 11521.53913843437, 11012.39431831257, 11114.49984750672, 11235.101191904465, 11308.0, 11421.543138274708], "value": 7178.703043302229, "unit": "score"}], "name": "dromaeo_css", "value": 7341.97955815329, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 112.0, 105.0, 109.0, 109.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 157.0, 183.0, 131.0, 154.0, 163.0, 129.0, 191.0, 126.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 76.0, 175.0, 74.0, 76.0, 74.0, 74.0, 174.0, 74.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 157.0, 93.0, 92.0, 91.0, 142.0, 92.0, 92.0, 154.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 55.0, 55.0, 54.0, 57.0, 75.0, 52.0, 53.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 59.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 79.0, 72.0, 73.0, 82.0, 80.0, 73.0, 72.0, 80.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 120.0, 122.0, 111.0, 112.0, 114.0, 117.0, 128.0, 115.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 167.0, 161.0, 168.0, 161.0, 159.0, 161.0, 159.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 69.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1518.7999999999997, "alertThreshold": 2.0}]} 09:24:47 INFO - Return code: 0 09:24:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:24:47 ERROR - # TBPL SUCCESS # 09:24:47 INFO - Running post-action listener: _resource_record_post_action 09:24:47 INFO - Running post-run listener: _resource_record_post_run 09:24:48 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 464621568; Read time: 0; Write time: 293068 09:24:48 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 242061312; Read time: 0; Write time: 205020 09:24:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 222253056; Read time: 0; Write time: 88024 09:24:48 INFO - Running post-run listener: _upload_blobber_files 09:24:48 INFO - Blob upload gear active. 09:24:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:24:48 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 09:24:48 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'] 09:24:48 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 09:24:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:24:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:24:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:24:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:49 INFO - (blobuploader) - INFO - Done attempting. 09:24:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:24:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:24:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:50 INFO - (blobuploader) - INFO - Done attempting. 09:24:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:50 INFO - Return code: 0 09:24:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f0cb9968249708e98b9d0defbd2593c556cef4c4065f0d3a3b18a5891468201a15e4c4d9be0861dd7d3a2895a746b7a8ec8f617417ff088e57c76e15d7bfb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30325737c1261ac91020ba7c1a78698f0e2b1c2ed22ac0e875955e2f969af4e20bdff80fbcf86286b5af0ab2711271e9e48764363d8fcbbcbda06235da7b4e7e"} 09:24:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:50 INFO - Contents: 09:24:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34f0cb9968249708e98b9d0defbd2593c556cef4c4065f0d3a3b18a5891468201a15e4c4d9be0861dd7d3a2895a746b7a8ec8f617417ff088e57c76e15d7bfb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30325737c1261ac91020ba7c1a78698f0e2b1c2ed22ac0e875955e2f969af4e20bdff80fbcf86286b5af0ab2711271e9e48764363d8fcbbcbda06235da7b4e7e"} 09:24:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:50 INFO - Copying logs to upload dir... 09:24:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.230843 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-06 09:24:49.915562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:49.918990) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452 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/34f0cb9968249708e98b9d0defbd2593c556cef4c4065f0d3a3b18a5891468201a15e4c4d9be0861dd7d3a2895a746b7a8ec8f617417ff088e57c76e15d7bfb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30325737c1261ac91020ba7c1a78698f0e2b1c2ed22ac0e875955e2f969af4e20bdff80fbcf86286b5af0ab2711271e9e48764363d8fcbbcbda06235da7b4e7e"} build_url:https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/SRUxByAXRlGB18mDv1RSDQ/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/34f0cb9968249708e98b9d0defbd2593c556cef4c4065f0d3a3b18a5891468201a15e4c4d9be0861dd7d3a2895a746b7a8ec8f617417ff088e57c76e15d7bfb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30325737c1261ac91020ba7c1a78698f0e2b1c2ed22ac0e875955e2f969af4e20bdff80fbcf86286b5af0ab2711271e9e48764363d8fcbbcbda06235da7b4e7e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:49.944938) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:49.945286) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467821066.536437-70232452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:50.030385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 09:24:50.030708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 09:24:50.030996) ========= ========= Total master_lag: 0.17 =========