builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1460993836.39 results: success (0) buildid: 20160418053003 builduid: 825a954336444f82993beeb8674e9964 revision: 4bc053de842538e99e56927b3c03fdc539374a16 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.391895) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.392391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.392680) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.414078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.414450) ========= 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=1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 08:37:17-- 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% 45.9M=0s 2016-04-18 08:37:17 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095708 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.523770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.524116) ========= 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=1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015175 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.573650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:16.573997) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4bc053de842538e99e56927b3c03fdc539374a16 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4bc053de842538e99e56927b3c03fdc539374a16 --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=1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 08:37:17,446 truncating revision to first 12 chars 2016-04-18 08:37:17,446 Setting DEBUG logging. 2016-04-18 08:37:17,446 attempt 1/10 2016-04-18 08:37:17,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4bc053de8425?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 08:37:17,715 unpacking tar archive at: fx-team-4bc053de8425/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:17.176156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:17.176484) ========= script_repo_revision: 4bc053de842538e99e56927b3c03fdc539374a16 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:17.177027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:17.177327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 08:37:17.185856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-18 08:37:17.186175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:37:18 INFO - MultiFileLogger online at 20160418 08:37:18 in /builds/slave/test 08:37:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:37:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:37:18 INFO - {'append_to_log': False, 08:37:18 INFO - 'base_work_dir': '/builds/slave/test', 08:37:18 INFO - 'blob_upload_branch': 'Fx-Team', 08:37:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:37:18 INFO - 'branch': 'Fx-Team', 08:37:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:37:18 INFO - 'config_files': ('talos/linux_config.py',), 08:37:18 INFO - 'default_actions': ('clobber', 08:37:18 INFO - 'read-buildbot-config', 08:37:18 INFO - 'download-and-extract', 08:37:18 INFO - 'populate-webroot', 08:37:18 INFO - 'create-virtualenv', 08:37:18 INFO - 'install', 08:37:18 INFO - 'run-tests'), 08:37:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:37:18 INFO - 'download_minidump_stackwalk': True, 08:37:18 INFO - 'download_symbols': 'ondemand', 08:37:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:37:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:37:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:37:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:37:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:37:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:37:18 INFO - 'installer_path': 'installer.exe', 08:37:18 INFO - 'log_level': 'info', 08:37:18 INFO - 'log_name': 'talos', 08:37:18 INFO - 'log_to_console': True, 08:37:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:37:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:37:18 INFO - 'opt_config_files': (), 08:37:18 INFO - 'pip_index': False, 08:37:18 INFO - 'sps_profile': False, 08:37:18 INFO - 'sps_profile_interval': 0, 08:37:18 INFO - 'suite': 'dromaeojs', 08:37:18 INFO - 'system_bits': '32', 08:37:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:37:18 INFO - 'title': 'talos-linux64-ix-027', 08:37:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:37:18 INFO - 'use_talos_json': True, 08:37:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:37:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:37:18 INFO - 'work_dir': 'build'} 08:37:18 INFO - ##### 08:37:18 INFO - ##### Running clobber step. 08:37:18 INFO - ##### 08:37:18 INFO - Running pre-action listener: _resource_record_pre_action 08:37:18 INFO - Running main action method: clobber 08:37:18 INFO - rmtree: /builds/slave/test/build 08:37:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:37:19 INFO - Running post-action listener: _resource_record_post_action 08:37:19 INFO - ##### 08:37:19 INFO - ##### Running read-buildbot-config step. 08:37:19 INFO - ##### 08:37:19 INFO - Running pre-action listener: _resource_record_pre_action 08:37:19 INFO - Running main action method: read_buildbot_config 08:37:19 INFO - Using buildbot properties: 08:37:19 INFO - { 08:37:19 INFO - "project": "", 08:37:19 INFO - "product": "firefox", 08:37:19 INFO - "script_repo_revision": "production", 08:37:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:37:19 INFO - "repository": "", 08:37:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:37:19 INFO - "buildid": "20160418053003", 08:37:19 INFO - "pgo_build": "True", 08:37:19 INFO - "basedir": "/builds/slave/test", 08:37:19 INFO - "buildnumber": 1099, 08:37:19 INFO - "slavename": "talos-linux64-ix-027", 08:37:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:37:19 INFO - "platform": "ubuntu64_hw", 08:37:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:37:19 INFO - "branch": "fx-team", 08:37:19 INFO - "repo_path": "integration/fx-team", 08:37:19 INFO - "revision": "4bc053de842538e99e56927b3c03fdc539374a16", 08:37:19 INFO - "stage_platform": "linux64-pgo", 08:37:19 INFO - "builduid": "825a954336444f82993beeb8674e9964", 08:37:19 INFO - "slavebuilddir": "test" 08:37:19 INFO - } 08:37:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:37:19 INFO - Running post-action listener: _resource_record_post_action 08:37:19 INFO - ##### 08:37:19 INFO - ##### Running download-and-extract step. 08:37:19 INFO - ##### 08:37:19 INFO - Running pre-action listener: _resource_record_pre_action 08:37:19 INFO - Running main action method: download_and_extract 08:37:19 INFO - mkdir: /builds/slave/test/build/tests 08:37:19 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')]} 08:37:19 INFO - https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:37:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:37:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:37:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:37:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:37:29 INFO - Downloaded 1361 bytes. 08:37:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:37:29 INFO - Using the following test package requirements: 08:37:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:37:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:37:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:29 INFO - u'jsshell-linux-x86_64.zip'], 08:37:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:37:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:37:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:37:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:37:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:37:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:37: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')]} 08:37:29 INFO - https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:37:43 INFO - Downloaded 23774949 bytes. 08:37:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:37:45 INFO - Return code: 0 08:37:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:37: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')]} 08:37:45 INFO - https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:37:46 INFO - Downloaded 23774949 bytes. 08:37:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:37:48 INFO - Return code: 0 08:37: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')]} 08:37:48 INFO - https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:37:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:37:49 INFO - Downloaded 10841076 bytes. 08:37:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:37:49 INFO - Return code: 0 08:37:49 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')]} 08:37:49 INFO - https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:37:52 INFO - Downloaded 58240547 bytes. 08:37:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:37:52 INFO - mkdir: /builds/slave/test/properties 08:37:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:37:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:37:52 INFO - Contents: 08:37:52 INFO - build_url:https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:37:54 INFO - Running post-action listener: _resource_record_post_action 08:37:54 INFO - Running post-action listener: set_extra_try_arguments 08:37:54 INFO - ##### 08:37:54 INFO - ##### Running populate-webroot step. 08:37:54 INFO - ##### 08:37:54 INFO - Running pre-action listener: _resource_record_pre_action 08:37:54 INFO - Running main action method: populate_webroot 08:37:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:37:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:37:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:37:54 INFO - '--tppagecycles', 08:37:54 INFO - '7'], 08:37:54 INFO - 'tests': ['tsvgm']}}, 08:37:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:37:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:37:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:37:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:37:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:54 INFO - 'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:54 INFO - 'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['damp', 'tps']}, 08:37:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:54 INFO - 'tests': ['damp', 'tps']}, 08:37:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['dromaeo_dom']}, 08:37:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:37:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['a11yr', 08:37:54 INFO - 'ts_paint', 08:37:54 INFO - 'tpaint', 08:37:54 INFO - 'sessionrestore', 08:37:54 INFO - 'sessionrestore_no_auto_restore', 08:37:54 INFO - 'tabpaint']}, 08:37:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:37:54 INFO - 'ts_paint', 08:37:54 INFO - 'tpaint', 08:37:54 INFO - 'sessionrestore', 08:37:54 INFO - 'sessionrestore_no_auto_restore', 08:37:54 INFO - 'tabpaint']}, 08:37:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:37:54 INFO - 'ts_paint', 08:37:54 INFO - 'tpaint', 08:37:54 INFO - 'sessionrestore', 08:37:54 INFO - 'sessionrestore_no_auto_restore', 08:37:54 INFO - 'tabpaint']}, 08:37:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:37:54 INFO - 'ts_paint', 08:37:54 INFO - 'tpaint', 08:37:54 INFO - 'sessionrestore', 08:37:54 INFO - 'sessionrestore_no_auto_restore', 08:37:54 INFO - 'tabpaint']}, 08:37:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['a11yr', 08:37:54 INFO - 'ts_paint', 08:37:54 INFO - 'tpaint', 08:37:54 INFO - 'sessionrestore', 08:37:54 INFO - 'sessionrestore_no_auto_restore', 08:37:54 INFO - 'tabpaint']}, 08:37:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['a11yr', 08:37:54 INFO - 'ts_paint', 08:37:54 INFO - 'tpaint', 08:37:54 INFO - 'sessionrestore', 08:37:54 INFO - 'sessionrestore_no_auto_restore', 08:37:54 INFO - 'tabpaint']}, 08:37:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['tsvgx', 08:37:54 INFO - 'tsvgr_opacity', 08:37:54 INFO - 'tart', 08:37:54 INFO - 'tscrollx', 08:37:54 INFO - 'cart']}, 08:37:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:37:54 INFO - 'tsvgr_opacity', 08:37:54 INFO - 'tart', 08:37:54 INFO - 'tscrollx', 08:37:54 INFO - 'cart']}, 08:37:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:54 INFO - 'talos_options': ['--disable-e10s'], 08:37:54 INFO - 'tests': ['tp5o']}, 08:37:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:54 INFO - 'tests': ['tp5o']}, 08:37:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:54 INFO - 'talos_options': ['--disable-e10s', 08:37:54 INFO - '--xperf_path', 08:37:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:54 INFO - 'tests': ['tp5n']}, 08:37:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:54 INFO - 'talos_options': ['--xperf_path', 08:37:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:54 INFO - 'tests': ['tp5n']}}, 08:37:54 INFO - 'talos.zip': {'path': '', 08:37:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:37:54 INFO - Running post-action listener: _resource_record_post_action 08:37:54 INFO - ##### 08:37:54 INFO - ##### Running create-virtualenv step. 08:37:54 INFO - ##### 08:37:54 INFO - Running pre-action listener: _resource_record_pre_action 08:37:54 INFO - Running main action method: create_virtualenv 08:37:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:37:54 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 08:37:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:37:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:37:54 INFO - Using real prefix '/usr' 08:37:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:37:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:56 INFO - Installing pip.................done. 08:37:56 INFO - Return code: 0 08:37:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:37: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', 'pip>=1.5'] in /builds/slave/test/build 08:37: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 pip>=1.5 08:37:56 INFO - Using env: {'DISPLAY': ':0', 08:37:56 INFO - 'HOME': '/home/cltbld', 08:37:56 INFO - 'LANG': 'en_US.UTF-8', 08:37:56 INFO - 'LANGUAGE': 'en_US:en', 08:37:56 INFO - 'LOGNAME': 'cltbld', 08:37:56 INFO - 'MAIL': '/var/mail/cltbld', 08:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:56 INFO - 'MOZ_NO_REMOTE': '1', 08:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:56 INFO - 'NO_EM_RESTART': '1', 08:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:56 INFO - 'PWD': '/builds/slave/test', 08:37:56 INFO - 'SHELL': '/bin/bash', 08:37:56 INFO - 'SHLVL': '1', 08:37:56 INFO - 'TERM': 'linux', 08:37:56 INFO - 'TMOUT': '86400', 08:37:56 INFO - 'USER': 'cltbld', 08:37:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:56 INFO - '_': '/tools/buildbot/bin/python'} 08:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:56 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 08:37:56 INFO - Cleaning up... 08:37:56 INFO - Return code: 0 08:37:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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', '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 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:37: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', 'psutil>=0.7.1'] in /builds/slave/test/build 08:37: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 psutil>=0.7.1 08:37:56 INFO - Using env: {'DISPLAY': ':0', 08:37:56 INFO - 'HOME': '/home/cltbld', 08:37:56 INFO - 'LANG': 'en_US.UTF-8', 08:37:56 INFO - 'LANGUAGE': 'en_US:en', 08:37:56 INFO - 'LOGNAME': 'cltbld', 08:37:56 INFO - 'MAIL': '/var/mail/cltbld', 08:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:56 INFO - 'MOZ_NO_REMOTE': '1', 08:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:56 INFO - 'NO_EM_RESTART': '1', 08:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:56 INFO - 'PWD': '/builds/slave/test', 08:37:56 INFO - 'SHELL': '/bin/bash', 08:37:56 INFO - 'SHLVL': '1', 08:37:56 INFO - 'TERM': 'linux', 08:37:56 INFO - 'TMOUT': '86400', 08:37:56 INFO - 'USER': 'cltbld', 08:37:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:56 INFO - '_': '/tools/buildbot/bin/python'} 08:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:57 INFO - Downloading/unpacking psutil>=0.7.1 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:57 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 08:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:59 INFO - Installing collected packages: psutil 08:37:59 INFO - Running setup.py install for psutil 08:37:59 INFO - building 'psutil._psutil_linux' extension 08:37:59 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 08:37:59 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 08:37:59 INFO - building 'psutil._psutil_posix' extension 08:37:59 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 08:37:59 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 08:37:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:59 INFO - Successfully installed psutil 08:37:59 INFO - Cleaning up... 08:37:59 INFO - Return code: 0 08:37:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:37:59 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')]} 08:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:59 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')]} 08:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:59 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 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:37:59 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 08:37:59 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 08:37:59 INFO - Using env: {'DISPLAY': ':0', 08:37:59 INFO - 'HOME': '/home/cltbld', 08:37:59 INFO - 'LANG': 'en_US.UTF-8', 08:37:59 INFO - 'LANGUAGE': 'en_US:en', 08:37:59 INFO - 'LOGNAME': 'cltbld', 08:37:59 INFO - 'MAIL': '/var/mail/cltbld', 08:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:59 INFO - 'MOZ_NO_REMOTE': '1', 08:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:59 INFO - 'NO_EM_RESTART': '1', 08:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:59 INFO - 'PWD': '/builds/slave/test', 08:37:59 INFO - 'SHELL': '/bin/bash', 08:37:59 INFO - 'SHLVL': '1', 08:37:59 INFO - 'TERM': 'linux', 08:37:59 INFO - 'TMOUT': '86400', 08:37:59 INFO - 'USER': 'cltbld', 08:37:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:59 INFO - '_': '/tools/buildbot/bin/python'} 08:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:37: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 08:37: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 08:37: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 08:37: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 08:37: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 08:37: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 08:38:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:38:01 INFO - Installing collected packages: mozsystemmonitor 08:38:01 INFO - Running setup.py install for mozsystemmonitor 08:38:01 INFO - Successfully installed mozsystemmonitor 08:38:01 INFO - Cleaning up... 08:38:01 INFO - Return code: 0 08:38:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:01 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 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:38:01 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 08:38:01 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 08:38:01 INFO - Using env: {'DISPLAY': ':0', 08:38:01 INFO - 'HOME': '/home/cltbld', 08:38:01 INFO - 'LANG': 'en_US.UTF-8', 08:38:01 INFO - 'LANGUAGE': 'en_US:en', 08:38:01 INFO - 'LOGNAME': 'cltbld', 08:38:01 INFO - 'MAIL': '/var/mail/cltbld', 08:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:01 INFO - 'MOZ_NO_REMOTE': '1', 08:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:01 INFO - 'NO_EM_RESTART': '1', 08:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:01 INFO - 'PWD': '/builds/slave/test', 08:38:01 INFO - 'SHELL': '/bin/bash', 08:38:01 INFO - 'SHLVL': '1', 08:38:01 INFO - 'TERM': 'linux', 08:38:01 INFO - 'TMOUT': '86400', 08:38:01 INFO - 'USER': 'cltbld', 08:38:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:01 INFO - '_': '/tools/buildbot/bin/python'} 08:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:02 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 08:38:02 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 08:38:02 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 08:38:02 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 08:38:02 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 08:38:02 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 08:38:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:04 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 08:38:04 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 08:38:04 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 08:38:04 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 08:38:04 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 08:38:04 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 08:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:04 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 08:38:04 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 08:38:04 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 08:38:04 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 08:38:04 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 08:38:04 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 08:38:04 INFO - Downloading docopt-0.6.1.tar.gz 08:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:04 INFO - Running setup.py install for blobuploader 08:38:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:38:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:38:05 INFO - Running setup.py install for requests 08:38:05 INFO - Running setup.py install for docopt 08:38:05 INFO - Successfully installed blobuploader requests docopt 08:38:05 INFO - Cleaning up... 08:38:05 INFO - Return code: 0 08:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:05 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 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:38:05 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 08:38:05 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 08:38:05 INFO - Using env: {'DISPLAY': ':0', 08:38:05 INFO - 'HOME': '/home/cltbld', 08:38:05 INFO - 'LANG': 'en_US.UTF-8', 08:38:05 INFO - 'LANGUAGE': 'en_US:en', 08:38:05 INFO - 'LOGNAME': 'cltbld', 08:38:05 INFO - 'MAIL': '/var/mail/cltbld', 08:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:05 INFO - 'MOZ_NO_REMOTE': '1', 08:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:05 INFO - 'NO_EM_RESTART': '1', 08:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:05 INFO - 'PWD': '/builds/slave/test', 08:38:05 INFO - 'SHELL': '/bin/bash', 08:38:05 INFO - 'SHLVL': '1', 08:38:05 INFO - 'TERM': 'linux', 08:38:05 INFO - 'TMOUT': '86400', 08:38:05 INFO - 'USER': 'cltbld', 08:38:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:05 INFO - '_': '/tools/buildbot/bin/python'} 08:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:05 INFO - Running setup.py (path:/tmp/pip-JuVoFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:05 INFO - Running setup.py (path:/tmp/pip-QDJUmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:05 INFO - Running setup.py (path:/tmp/pip-XJeFne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:05 INFO - Running setup.py (path:/tmp/pip-2TtanN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:06 INFO - Running setup.py (path:/tmp/pip-sZpYmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:06 INFO - Running setup.py (path:/tmp/pip-9wSJTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:06 INFO - Running setup.py (path:/tmp/pip-beahSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:06 INFO - Running setup.py (path:/tmp/pip-0VTbu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:06 INFO - Running setup.py (path:/tmp/pip-5MsM1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:06 INFO - Running setup.py (path:/tmp/pip-qeib1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:06 INFO - Running setup.py (path:/tmp/pip-FK4_gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:06 INFO - Running setup.py (path:/tmp/pip-n3Gmil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:06 INFO - Running setup.py (path:/tmp/pip-YzIo5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:06 INFO - Running setup.py (path:/tmp/pip-VErSLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:06 INFO - Running setup.py (path:/tmp/pip-s6RlOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:06 INFO - Running setup.py (path:/tmp/pip-I4E41Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:06 INFO - Running setup.py (path:/tmp/pip-PCCCBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:06 INFO - Running setup.py install for manifestparser 08:38:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozcrash 08:38:07 INFO - Running setup.py install for mozdebug 08:38:07 INFO - Running setup.py install for mozdevice 08:38:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozfile 08:38:07 INFO - Running setup.py install for mozhttpd 08:38:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozinfo 08:38:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozInstall 08:38:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozleak 08:38:07 INFO - Running setup.py install for mozlog 08:38:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for moznetwork 08:38:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozprocess 08:38:08 INFO - Running setup.py install for mozprofile 08:38:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozrunner 08:38:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozscreenshot 08:38:08 INFO - Running setup.py install for moztest 08:38:08 INFO - Running setup.py install for mozversion 08:38:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:08 INFO - Cleaning up... 08:38:08 INFO - Return code: 0 08:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:08 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 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:38:08 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 08:38:08 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 08:38:08 INFO - Using env: {'DISPLAY': ':0', 08:38:08 INFO - 'HOME': '/home/cltbld', 08:38:08 INFO - 'LANG': 'en_US.UTF-8', 08:38:08 INFO - 'LANGUAGE': 'en_US:en', 08:38:08 INFO - 'LOGNAME': 'cltbld', 08:38:08 INFO - 'MAIL': '/var/mail/cltbld', 08:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:08 INFO - 'MOZ_NO_REMOTE': '1', 08:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:08 INFO - 'NO_EM_RESTART': '1', 08:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:08 INFO - 'PWD': '/builds/slave/test', 08:38:08 INFO - 'SHELL': '/bin/bash', 08:38:08 INFO - 'SHLVL': '1', 08:38:08 INFO - 'TERM': 'linux', 08:38:08 INFO - 'TMOUT': '86400', 08:38:08 INFO - 'USER': 'cltbld', 08:38:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:08 INFO - '_': '/tools/buildbot/bin/python'} 08:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:09 INFO - Running setup.py (path:/tmp/pip-y3LmiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:09 INFO - Running setup.py (path:/tmp/pip-CxLCSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:09 INFO - Running setup.py (path:/tmp/pip-UKSGDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:09 INFO - Running setup.py (path:/tmp/pip-hie3Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:09 INFO - Running setup.py (path:/tmp/pip-m2Ahxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:09 INFO - Running setup.py (path:/tmp/pip-piSpVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:09 INFO - Running setup.py (path:/tmp/pip-GjOXAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:09 INFO - Running setup.py (path:/tmp/pip-BgFiUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:09 INFO - Running setup.py (path:/tmp/pip-_uDdje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:09 INFO - Running setup.py (path:/tmp/pip-SKn47G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:09 INFO - Running setup.py (path:/tmp/pip-qrbH6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:09 INFO - Running setup.py (path:/tmp/pip-MvJEa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:09 INFO - Running setup.py (path:/tmp/pip-R3Nb2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:09 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)) 08:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:09 INFO - Running setup.py (path:/tmp/pip-2EAWRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:10 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)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:10 INFO - Running setup.py (path:/tmp/pip-TIf5ZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:10 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)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:10 INFO - Running setup.py (path:/tmp/pip-ZqwkVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:10 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)) 08:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:10 INFO - Running setup.py (path:/tmp/pip-r9WPhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:10 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)) 08:38:10 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)) 08:38:10 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)) 08:38:10 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)) 08:38:10 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)) 08:38:10 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)) 08:38:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:10 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 08:38:12 INFO - Downloading blessings-1.6.tar.gz 08:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:38:12 INFO - Installing collected packages: blessings 08:38:12 INFO - Running setup.py install for blessings 08:38:12 INFO - Successfully installed blessings 08:38:12 INFO - Cleaning up... 08:38:12 INFO - Return code: 0 08:38:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:12 INFO - Reading from file tmpfile_stdout 08:38:12 INFO - Current package versions: 08:38:12 INFO - argparse == 1.2.1 08:38:12 INFO - blessings == 1.6 08:38:12 INFO - blobuploader == 1.2.4 08:38:12 INFO - docopt == 0.6.1 08:38:12 INFO - manifestparser == 1.1 08:38:12 INFO - mozInstall == 1.12 08:38:12 INFO - mozcrash == 0.17 08:38:12 INFO - mozdebug == 0.1 08:38:12 INFO - mozdevice == 0.48 08:38:12 INFO - mozfile == 1.2 08:38:12 INFO - mozhttpd == 0.7 08:38:12 INFO - mozinfo == 0.9 08:38:12 INFO - mozleak == 0.1 08:38:12 INFO - mozlog == 3.1 08:38:12 INFO - moznetwork == 0.27 08:38:12 INFO - mozprocess == 0.22 08:38:12 INFO - mozprofile == 0.28 08:38:12 INFO - mozrunner == 6.11 08:38:12 INFO - mozscreenshot == 0.1 08:38:12 INFO - mozsystemmonitor == 0.0 08:38:12 INFO - moztest == 0.7 08:38:12 INFO - mozversion == 1.4 08:38:12 INFO - psutil == 3.1.1 08:38:12 INFO - requests == 1.2.3 08:38:12 INFO - wsgiref == 0.1.2 08:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:12 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 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:38:12 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 08:38:12 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 08:38:12 INFO - Using env: {'DISPLAY': ':0', 08:38:12 INFO - 'HOME': '/home/cltbld', 08:38:12 INFO - 'LANG': 'en_US.UTF-8', 08:38:12 INFO - 'LANGUAGE': 'en_US:en', 08:38:12 INFO - 'LOGNAME': 'cltbld', 08:38:12 INFO - 'MAIL': '/var/mail/cltbld', 08:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:12 INFO - 'MOZ_NO_REMOTE': '1', 08:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:12 INFO - 'NO_EM_RESTART': '1', 08:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:12 INFO - 'PWD': '/builds/slave/test', 08:38:12 INFO - 'SHELL': '/bin/bash', 08:38:12 INFO - 'SHLVL': '1', 08:38:12 INFO - 'TERM': 'linux', 08:38:12 INFO - 'TMOUT': '86400', 08:38:12 INFO - 'USER': 'cltbld', 08:38:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:12 INFO - '_': '/tools/buildbot/bin/python'} 08:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 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)) 08:38:12 INFO - Cleaning up... 08:38:12 INFO - Return code: 0 08:38:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:12 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 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:38:12 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 08:38:12 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 08:38:12 INFO - Using env: {'DISPLAY': ':0', 08:38:12 INFO - 'HOME': '/home/cltbld', 08:38:12 INFO - 'LANG': 'en_US.UTF-8', 08:38:12 INFO - 'LANGUAGE': 'en_US:en', 08:38:12 INFO - 'LOGNAME': 'cltbld', 08:38:12 INFO - 'MAIL': '/var/mail/cltbld', 08:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:12 INFO - 'MOZ_NO_REMOTE': '1', 08:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:12 INFO - 'NO_EM_RESTART': '1', 08:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:12 INFO - 'PWD': '/builds/slave/test', 08:38:12 INFO - 'SHELL': '/bin/bash', 08:38:12 INFO - 'SHLVL': '1', 08:38:12 INFO - 'TERM': 'linux', 08:38:12 INFO - 'TMOUT': '86400', 08:38:12 INFO - 'USER': 'cltbld', 08:38:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:12 INFO - '_': '/tools/buildbot/bin/python'} 08:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:12 INFO - Downloading/unpacking jsonschema 08:38:12 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 08:38:12 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 08:38:12 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 08:38:12 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 08:38:12 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 08:38:12 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 08:38:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:38:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:38:14 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 08:38:14 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 08:38:14 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 08:38:14 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 08:38:14 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 08:38:14 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 08:38:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:15 INFO - warning: no files found matching '*.txt' 08:38:15 INFO - no previously-included directories found matching 'build' 08:38:15 INFO - no previously-included directories found matching 'dist' 08:38:15 INFO - no previously-included directories found matching '.git*' 08:38:15 INFO - Installing collected packages: jsonschema, functools32 08:38:15 INFO - Running setup.py install for functools32 08:38:15 INFO - warning: no files found matching '*.txt' 08:38:15 INFO - no previously-included directories found matching 'build' 08:38:15 INFO - no previously-included directories found matching 'dist' 08:38:15 INFO - no previously-included directories found matching '.git*' 08:38:15 INFO - Successfully installed jsonschema functools32 08:38:15 INFO - Cleaning up... 08:38:15 INFO - Return code: 0 08:38:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:38: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')]} 08:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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')]} 08:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:15 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 0x7f70440caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x258b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, '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': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', '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 08:38:15 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 08:38:15 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 08:38:15 INFO - Using env: {'DISPLAY': ':0', 08:38:15 INFO - 'HOME': '/home/cltbld', 08:38:15 INFO - 'LANG': 'en_US.UTF-8', 08:38:15 INFO - 'LANGUAGE': 'en_US:en', 08:38:15 INFO - 'LOGNAME': 'cltbld', 08:38:15 INFO - 'MAIL': '/var/mail/cltbld', 08:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:15 INFO - 'MOZ_NO_REMOTE': '1', 08:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:15 INFO - 'NO_EM_RESTART': '1', 08:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:15 INFO - 'PWD': '/builds/slave/test', 08:38:15 INFO - 'SHELL': '/bin/bash', 08:38:15 INFO - 'SHLVL': '1', 08:38:15 INFO - 'TERM': 'linux', 08:38:15 INFO - 'TMOUT': '86400', 08:38:15 INFO - 'USER': 'cltbld', 08:38:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:15 INFO - '_': '/tools/buildbot/bin/python'} 08:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:15 INFO - Downloading/unpacking flake8 08:38:15 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 08:38:15 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 08:38:15 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 08:38:15 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 08:38:15 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 08:38:15 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 08:38:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:38:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:38:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:17 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 08:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:38:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:38:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:38:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:38:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:38:18 INFO - no previously-included directories found matching 'docs/_build' 08:38:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:38:18 INFO - Running setup.py install for pep8 08:38:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:38:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:38:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:38:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:38:18 INFO - no previously-included directories found matching 'docs/_build' 08:38:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:38:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:38:18 INFO - Cleaning up... 08:38:18 INFO - Return code: 0 08:38:18 INFO - Running post-action listener: _resource_record_post_action 08:38:18 INFO - Running post-action listener: _start_resource_monitoring 08:38:18 INFO - Starting resource monitoring. 08:38:18 INFO - ##### 08:38:18 INFO - ##### Running install step. 08:38:18 INFO - ##### 08:38:18 INFO - Running pre-action listener: _resource_record_pre_action 08:38:18 INFO - Running main action method: install 08:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:18 INFO - Reading from file tmpfile_stdout 08:38:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:38:18 INFO - Reading from file tmpfile_stdout 08:38:18 INFO - Output received: 08:38:18 INFO - Usage: mozinstall [options] installer 08:38:18 INFO - Options: 08:38:18 INFO - -h, --help show this help message and exit 08:38:18 INFO - -d DEST, --destination=DEST 08:38:18 INFO - Directory to install application into. [default: 08:38:18 INFO - "/builds/slave/test"] 08:38:18 INFO - --app=APP Application being installed. [default: firefox] 08:38:18 INFO - mkdir: /builds/slave/test/build/application 08:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:38:35 INFO - Reading from file tmpfile_stdout 08:38:35 INFO - Output received: 08:38:35 INFO - /builds/slave/test/build/application/firefox/firefox 08:38:35 INFO - Running post-action listener: _resource_record_post_action 08:38:35 INFO - ##### 08:38:35 INFO - ##### Running run-tests step. 08:38:35 INFO - ##### 08:38:35 INFO - Running pre-action listener: _resource_record_pre_action 08:38:35 INFO - Running main action method: run_tests 08:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:38:35 INFO - Python 2.7.3 08:38:35 INFO - Return code: 0 08:38:35 INFO - grabbing minidump binary from tooltool 08:38: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')]} 08:38:35 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 0x261a810>, '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 0x261b710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261bba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:38:35 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 08:38:35 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 08:38:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:38:35 INFO - Return code: 0 08:38:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:38:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:38:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:38:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:38:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:38:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:38:36 INFO - Return code: 0 08:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 08:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 08:38:36 INFO - Using env: {'DISPLAY': ':0', 08:38:36 INFO - 'HOME': '/home/cltbld', 08:38:36 INFO - 'LANG': 'en_US.UTF-8', 08:38:36 INFO - 'LANGUAGE': 'en_US:en', 08:38:36 INFO - 'LOGNAME': 'cltbld', 08:38:36 INFO - 'MAIL': '/var/mail/cltbld', 08:38:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:38:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:36 INFO - 'MOZ_NO_REMOTE': '1', 08:38:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:36 INFO - 'NO_EM_RESTART': '1', 08:38:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:36 INFO - 'PWD': '/builds/slave/test', 08:38:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:38:36 INFO - 'SHELL': '/bin/bash', 08:38:36 INFO - 'SHLVL': '1', 08:38:36 INFO - 'TERM': 'linux', 08:38:36 INFO - 'TMOUT': '86400', 08:38:36 INFO - 'USER': 'cltbld', 08:38:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084', 08:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:36 INFO - '_': '/tools/buildbot/bin/python'} 08:38:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 08:38:36 INFO - mozversion application_buildid: 20160418053003 08:38:36 INFO - mozversion application_changeset: 4bc053de842538e99e56927b3c03fdc539374a16 08:38:36 INFO - mozversion application_display_name: Nightly 08:38:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:38:36 INFO - mozversion application_name: Firefox 08:38:36 INFO - mozversion application_remotingname: firefox 08:38:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:38:36 INFO - mozversion application_vendor: Mozilla 08:38:36 INFO - mozversion application_version: 48.0a1 08:38:36 INFO - mozversion platform_buildid: 20160418053003 08:38:36 INFO - mozversion platform_changeset: 4bc053de842538e99e56927b3c03fdc539374a16 08:38:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:38:36 INFO - mozversion platform_version: 48.0a1 08:38:36 INFO - using testdate: 1460993916 08:38:36 INFO - actual date: 1460993916 08:38:36 INFO - starting webserver on 'localhost:39614' 08:38:36 INFO - SUITE-START | Running 2 tests 08:38:36 INFO - TEST-START | dromaeo_css 08:38:36 INFO - operating with platform_type : linux_ 08:38:36 INFO - Initialising browser for dromaeo_css test... 08:38:36 INFO - TEST-INFO | started process 26498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1qkfID/profile http://localhost:39614/getInfo.html) 08:38:40 INFO - PROCESS | 26498 | __metrics Screen width/height:1600/1200 08:38:40 INFO - PROCESS | 26498 | colorDepth:24 08:38:40 INFO - PROCESS | 26498 | Browser inner width/height: 1024/697 08:38:40 INFO - PROCESS | 26498 | __metrics 08:38:41 ERROR - PROCESS | 26498 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:38:41 INFO - TEST-INFO | 26498: exit 0 08:38:41 INFO - Browser initialized. 08:38:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:38:41 INFO - TEST-INFO | started process 26579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1qkfID/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:53 INFO - PROCESS | 26579 | RSS: Main: 153673728 08:38:53 INFO - PROCESS | 26579 | 08:39:44 INFO - PROCESS | 26579 | 1460993984514 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] 08:41:51 INFO - PROCESS | 26579 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39614/tests/dromaeo/cssquery-ext.html) 08:41:52 INFO - PROCESS | 26579 | RSS: Main: 258560000 08:41:52 INFO - PROCESS | 26579 | 08:44:55 INFO - PROCESS | 26579 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-ext.html (next: http://localhost:39614/tests/dromaeo/cssquery-jquery.html) 08:44:55 INFO - PROCESS | 26579 | RSS: Main: 241246208 08:44:55 INFO - PROCESS | 26579 | 08:47:57 INFO - PROCESS | 26579 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39614/tests/dromaeo/cssquery-mootools.html) 08:47:58 INFO - PROCESS | 26579 | RSS: Main: 238604288 08:47:58 INFO - PROCESS | 26579 | 08:51:00 INFO - PROCESS | 26579 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39614/tests/dromaeo/cssquery-prototype.html) 08:51:00 INFO - PROCESS | 26579 | RSS: Main: 233050112 08:51:00 INFO - PROCESS | 26579 | 08:54:03 INFO - PROCESS | 26579 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39614/tests/dromaeo/cssquery-yui.html) 08:54:03 INFO - PROCESS | 26579 | RSS: Main: 220233728 08:54:03 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | Cycle 1(1): loaded http://localhost:39614/tests/dromaeo/cssquery-yui.html (next: http://localhost:39614/tests/dromaeo/cssquery-dojo.html) 08:57:06 INFO - PROCESS | 26579 | RSS: Main: 267153408 08:57:06 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | __start_tp_report 08:57:06 INFO - PROCESS | 26579 | _x_x_mozilla_page_load 08:57:06 INFO - PROCESS | 26579 | _x_x_mozilla_page_load_details 08:57:06 INFO - PROCESS | 26579 | |i|pagename|runs| 08:57:06 INFO - PROCESS | 26579 | |0;dojo.html;3003.5344521599154;3048.1922290592984;3085.089898479947;3094.2109762010696;3113.2216945763553;5191.636585439021;5220.504052115052;5225.0856100182455;5269.077911365515;5269.288646032789;5257.342832145981;5307.840764777054;5309;5324.41431442541;5339.06566350889;4735.834245801398;4778.402699662533;4869.586085182746;4912.189488734354;4939.925901111486;4829.6860704054125;4867.537583929521;4887.364642596457;4890.462049174588;4913.115639184945;4731.881702957419;4747.857564273095;4773.427188737373;4777.09235245304;4784.545468180518;4749.786259618326;4795;4797.544233297831;4802.471728109905;4838.927416088762;4681.5318468153255;4744.691595046311;4762.095201911626;4787.449443314029;4813.470518242991;5150.742462876841;5173.042987047371;5181.740912954338;5191.402988656315;5254.789808407659;5511.5039646432015;5513.448655134494;5516.558675305966;5527.419620939783;5529.806456773994;5544.140658197985;5582.637128586629;5606.971965140189;5651.06757385031;5651.208830763655;5158.432572417031;5169.974150129226;5178.741062946838;5178.948210517884;5231.921521177185;5623.775048998076;5639.154126881001;5639.210510528447;5643.971780141073;5650.63270887391;5407.729613519308;5420.430854760193;5468.125099983983;5556.138798486241;5580.693061881554;5577.8047768327915;5614.9438505615235;5616.5787565931905;5619.185218143346;5625.437456254342;5581.302337207849;5598.076317407664;5601.887962240732;5603.131514615241;5605.271314729059;5476.507114359647;5562.360328562268;5605.607607467438;5636.323641163087;5647.124695672177;4254.595813397722;4262.23279809631;4267.039916018871;4268.59448352406;4298.376735373354;3705.8332375043187;3818.809059547067;3828.2152158807376;3849.7882616455804;3872.4191371294532;5303.098473259478;5340.118880384693;5343.759530821122;5393.352797664227;5394.406615272317;5612.579056570774;5657.2928383952;5658.603897727202;5666.320041594952;5667;5186.222066690027;5247.081760691864;5292.92060619091;5327.174287985368;5398.703071331114;4866.537678920497;4883.096627123993;4887.511248875084;4904.926426103611;4933.654644174945;5835.328937172279;5837.357890632027;5838.1242813577455;5844.181814545882;5888.234529511136;5544.085225937675;5639.436056394492;5679.261695979496;5682.886342273214;5707.771689132388;5728.856778580569;5745.971270143623;5746.7701291949525;5777.191193233035;5795.710214489174;5521.3926468087675;5521.4478552144465;5522.834314970557;5524.944750552443;5539;5482.698451585201;5611.943880561143;5628.859278517906;5669;5715.657060576379;5502.0371434997915;5522.779088836402;5529.723513824212;5530.004599172027;5531.557475401878;5500.119980803052;5504.422035686195;5505.311836020497;5514.889702206014;5562.332520097452;5269.657472264291;5334.413214546475;5411.594130440154;5427.213054107211;5454.509094181542;5478.178273258884;5505.394406615349;5513.724313784375;5513.862153446196;5518.972405138109;5224.634275600672;5357.8392648220615;5405.729713514387;5413.918791218213;5415.48552887475 08:57:06 INFO - PROCESS | 26579 | |1;ext.html;611.5902345428563;645.1129696667083;658.0688326018685;674.7537148940638;677.8881484555052;32565.348693026153;33453.16367090818;33480;33505.329893402115;33549.49675754866;39136;40546.7972660137;40684.389734154014;40779.184416311655;40800.183996320055;8515.829683406328;8756.03683594804;8760.036395996436;8761;8763.737087887343;8596.398252122353;8726.345524085687;8730.781730456725;8731.34514911381;8731.519766412845;8740.912590874073;8837.64649414026;8842.29261659069;9037;9042.367034307601;8832.602532886003;8879.556022198929;8897.199252067312;8900.955495222515;8987.55062246885;8649.351298652626;8772.078931712205;8775.078616745213;8853.24747396472;8866.911330886738;40073;40255.194896102206;40320.19359612821;40353.596464035276;40389.79805100956;3213.9196520087185;3395.6604339565847;3417.2140407706365;3431.2965842002577;3662.267546490686;30580.54129188064;31233.219169520944;31443.213919651964;31532;31750.682493175234;4175.54069052404;4265.189613973335;4303.392138378911;4314.158739045887;4375.12497500498;282610;283391;284581;285180;286244;57313.426865730806;57463.71268143632;57596;57754.422455774904;57993;51605.741971289906;51610.22584661233;51618;51643.74178129085;56184.15723764147;16315.673686526203;16989.06560139204;17052.658946820993;17065.91467042657;17114.572135696708;12398.876011239772;12437.689057773447;12470.251784892935;12480.687982800502;12481.126321157431;15775.921120394325;17256.482305530855;17296.82703172952;17505.474835754947;17565.736513952303;5846.678432686158;6140.8771824564155;6226.719797609118;6236.844078898064;6316.842078948063;1075.8841707679933;1086.896744809242;1100.5487750022453;1182.0602620916393;1214.6416807041944;30994;32380.866669666448;32545.837270813496;32829.67170328314;33475.83262083674;1021.3004092196869;1067.6743593203992;1085.478970094359;1126.8929451702074;1197.874223206568;16824.915875420545;17519.91240043817;17546.473605791845;17571.714940882248;17691.557711057325;394660;483445;494841;495069;495087;51685.7415712919;52081.73959130256;52327.47672523302;52388.214176787376;52463.213051804254;1222.2544248008708;1264.6964728465102;1272.923624582528;1285.8521270053877;1372.5950844500896;28196.43607127887;29635.555466668447;29698.554521682625;30435.391292174474;32203.35593288168;46045;55065.72467137639;56547.434525654215;56715.71642141763;57110.143347848985;315275;315451;315662;317013;318137;26090;28218.43563128767;28314.716852832033;28923.7107628921;28939.131826045254;43327.13345733131;43401.3489797647;43486.13027739491;44352.778236108614;44412.77793611011;36946;37413.438798417505;37720.43419348767;39063.60936390713;39539.209215816096;38310;39718.2056358877;40307.3953890686;40370.59629403668;40791.7960410196;39571;40155.397669034406;41342.1731565361;41373.96565085897;41514.962125947095;34348.656513434544;35136.12159696028;35188.296234075686;36062.278754425286;36159.63840361563;27668.584971225046;28123.156305310873;28138.155855324374;28223.31878471542;28239.858800706686 08:57:06 INFO - PROCESS | 26579 | |2;jquery.html;389.7525071579547;394.38869751884573;398.0685196639862;399.4966342408565;407.5639066199168;14270.643233919158;16539.503814885542;18141.546461338457;18655.5336116597;18684.90657546712;17396;17630.47108586741;17817.109144542785;17844.10779461028;18222.544436389097;5057.519535644117;5175.767090480918;5194.558462530689;5197.480251974791;5213.139831927746;3851.691864650835;5121.129408000649;5169.379674439073;5432;5751.309842818868;5675.631083979549;5703.885922281552;5755.366909639936;5757.280339957505;5765.538756899438;5686.772529098831;6116.877662446748;6364.745410183587;6412.519061070392;6431.421172094534;5442.727863606804;5573.554115670737;5696.629719068289;5704.458076482728;5713.771449142029;13249;13395.933020334933;13441.596752097452;13489.325533723275;13499.865001350057;2138.9465263368384;2222.922197723088;2352.282553821084;2372.15788395119;2918.4746745585785;9204.861927071099;9657.517124143835;9767.365121267096;9811;9932.751681207956;1790.6239689665185;1839.6964500857343;1889.6504146732898;1891.0711074703863;1907.246637578149;77867.61066194689;80396.59801700954;81273.59363203264;81887;82421.17578824195;10674.146068314516;10884.07485363737;10906.672799816019;10985.395803230898;10990.340579565252;15412.922935385252;15438.150901700514;15466;15483.612909677347;15483.922580387027;8051.114377418479;8210.425270231026;8269.875951860728;8420.410571259952;8438.873416898752;7880.960595196987;7985.201479852085;8011.919880801117;8098.83802323962;8111.594420278962;4688.929666055012;4745.3593764842;4797.040591881638;4808.471068182497;4855.562999330077;1782.5454509100355;1788.9552761181073;1876.9343072992654;1905.1902941249914;2044.9693254601193;977.5600979559226;991.4745185051934;1002.1782138646386;1109.909981717358;1115.6987613344352;18097;18480.722789158175;18958.81041189598;19554.413367598994;19673;1004.1966426858484;1011.6964910526813;1044.1698849414734;1105.9668209953713;1110.8111621024445;10533.157347412189;10583.947080264703;10652.147828173727;10743.355398675949;10744.892551074545;418601;419791;455488;478719;483638;91432.5428372854;92624.53687731519;92971.53514232521;96793.5160324208;97878;1013.7871047080048;1021.877374715039;1022.4887556221889;1035.5547114740734;1036.0727149201423;16232.837671623132;16640;16845.062817776114;16966.406175783788;17145.399911003056;37133;37440.59267542642;38610.80694596509;38868.80565597154;40180.39729404003;55484.72257638686;55869.720651396485;56997.43002570087;57457.425425745205;57629;8320.750377488685;8377.916220837957;8412.369072319723;8462.111478294937;8544.273736732199;8822.707214312853;11502.654920352403;12534.185277956904;13256;13308.268045257604;11727.237729547553;11809.291442513477;11912.821307680219;11982;12054;11491.138164637518;11535.711607209887;11602.767944640891;11772.411379430823;11868.703282418008;12049.216800907912;12180.45187966526;12312.26126432417;12426.875731242571;12640.178388404724;8227.83544329122;8301.501909885426;8341.708040218806;8425.662973481238;8499.915000849913;11371.545138194711;11836.58571950012;11855.229410088317;11882.702932426759;11939.82090268664 08:57:06 INFO - PROCESS | 26579 | |3;mootools.html;1279.577739346016;1514.409380341667;1533.7239296926555;1675.279629759203;1811.266437092977;7759.262870027345;8037;8043.55760433176;8043.79890502737;8053.637586308616;7807.453478256524;7928.445008849369;7935.4048446366605;7937.325327347183;7942.563159026251;2006.8695534790193;2264.388615073929;2272.4659704969317;2301.2060839010514;2327.4763178284834;2303.389601755536;2326.5230627721276;2327.429779703975;2330.4057465346395;2331.73185083715;2268.7844654757773;2303.2744685424123;2305.700258966332;2306;2306.1351993002622;1942.9125689344014;2253.7971582557566;2319.884005799703;2320.9883950580224;2323.3378487131085;2249.966250506244;2252.8986195621237;2254.1546919905036;2254.751977282514;2303.470201853583;8100.473469224482;8254.752357429286;8290.46112002724;8315.459495132858;8326.2506374426;4836.540528649773;4991.07665081961;5001.299818025443;5035.194368900959;5036.874078148076;3362.4620060790157;3362.882299119519;3421.9657803421896;3428.7257019438384;3432.6910578048096;1127.1715289262468;1127.787628299573;1140.5380820767602;1159.6463078760974;1168.5559487394821;11059.944700276446;11135.10919126476;11151.665450036511;11159.553617855276;11183.888161118448;4234.87295381139;4322.265214913472;4439.977800110979;4445.599896009375;4523.592876641118;9396.436213827192;9451.621935122517;9467.621295148117;9469.905300946903;9480.762980925394;4572.0627271409285;4946.258061290835;4990.30135780991;4995.925061124086;5001.299818025479;4497.820087196541;4624;4626.236670949255;4629.0973260214605;4647.34937108805;3823.0824602095295;3836.271108489378;3902.804859757001;3924.47019652349;3946.7631942082994;1298.7597294500547;1305.9151155174884;1305.9542915997895;1314.6450458376376;1323.7881938889732;745.2063552316765;854.448880472092;901.2609660078673;907.1654078248027;916.9495677737789;5482.725863706799;5573;5708.771649134072;5784.4504772046585;5850.3272123705465;968.5012218707371;1069.6042464288264;1112.67732357617;1117.1677100559973;1118.8377685235757;4131.710780245414;4241;4299.656027517791;4340.565943405634;4380.058287468146;9895.901040989642;10093.24300677452;10277.691669249934;10282.588696452207;10285.2800303978;10009.099181073738;10162.339447935861;10191.7452063699;10205.489725513695;10214.693559193236;7562.584057876869;7711.190325015905;7724.3434308083315;7901.446898717035;7904.525728456311;5828.562857785599;5871.236739223874;5908;6063.636181829104;6064.211652485149;9140.314476414429;9238.491882946502;9295;9318.580663870007;9385.812283754423;9576;9610.615575377185;9614.95192524033;9723.201207776585;9738.464384458923;6476.708548115252;7001.264867189076;7156.749513766993;7177.174624917992;7301.233370496021;7610.467267291237;7640.426967977535;7688.115866675404;7699.615019249127;7717.073951125901;6934.271901450275;7057.0472986146215;7071.858562828817;7135.5361901476235;7230.13238411394;6813.182418109858;6872.587644741331;6889.035535025;6915.101036865175;7088.716451341888;6676.632785196861;6681.966590167018;6730.596164230162;6733.595984240961;6735.259121496533;5075.670081444694;5101.362329708786;5122;5150.665206761549;5193.039287731782;5018.44797072329;5020.171671674133;5073.974630126826;5149.382074151126;5192.221166825007 08:57:06 INFO - PROCESS | 26579 | |4;prototype.html;332.9117783787297;335.11863798210703;335.6878103363871;343.5190732973838;346.4941185868632;5606;5660.971695141524;5662.310402558787;5684.573656975723;5705.5720820938495;5585.162225666152;5600.383957764642;5608.411116832735;5621.184928185421;5639.605227634067;4140.482439695038;4209.957900421003;4335.241332766769;4337.240982828008;4368.58498442649;4307.353896915472;4316.920769807548;4334.371516130175;4354.825806967718;4360.324149756792;4116.97941510292;4336.522982471925;4351.325544540601;4352.912941741163;4368.213721530124;4013.4782478277784;4259.382389553512;4310.396544483775;4323.675724320657;4349.586789255048;3827.3876179811095;3830.6743926766258;3833.677381303474;3839.4432807242792;3850.5186851643543;5294.41761406245;5400.513953744143;5404.297441332641;5411.323584551931;5433.266509021271;4987.127252730757;5010.348654674905;5011.3485246918035;5013.523715247045;5028.446870844205;5821.50517206038;5842.503387212092;5856.912146317809;5859.6777177255235;5875.236219291465;4062.2078694654556;4222.683298752575;4227.471566054243;4238.3430568261965;4253.404523366731;6092.603980741238;6095.2685677718955;6119.44924956756;6127.203463549755;6155.815325540241;4294.26997410441;4315.546867578922;4330.415393921843;4332.133573285356;4341.9565804341555;4250.577171012494;4353.49934757507;4378.598848368491;4380.255356589388;4390.100029493946;4944.7638090477385;4956.207006878882;4970.980948905466;5000.499950004971;5010.670038432147;5872.941270587239;5912.645241285537;5914.467697907123;5914.940850591525;5941.70291485424;1494.133402626474;1497.4010395841533;1520.1791032842361;1524.291204589871;1525.2678714217238;977.9559919803626;1004.924630652704;1033.7777377863795;1040.9843852342221;1045.7751583409452;5634.464725851038;5689.34572524165;5705.174344209813;5714.942850571441;5723.227364305849;5997.880042399128;6022.36765139654;6029.306629737636;6030.185924900083;6061.424164704346;5482.122860342326;5640.7743690252755;5674.716264186774;5677;5715.628484148517;3128.749700023993;3190.2502911815704;3190.6649801770945;3205.5031470122167;3221.5650887130405;5990.7304171311525;6140.385961403824;6163.291221509494;6168.9691551541955;6200.968995154995;6059.394060593993;6117.571769976148;6125.785597504066;6133.902379298425;6150.138980542728;6058.909116363258;6156.384361563897;6156.846078848064;6171.444569988633;6183.81448556544;5870.471657550841;5967.850803729942;5974.312954010345;5978.970105149447;5984.341722410619;5823.5923485355615;5833.620814647034;5861.6189947653265;5879.941200587939;5891.852703682443;5910.23166988306;6111.388861113853;6113;6135.233095863017;6169.84575385619;4301.182775272689;4302.526722060508;4307.440032795716;4317.309230523101;4318.201132790444;5912.704364781658;5939.990201665813;5967.254093238345;5969.104634304889;5979.4618484336615;5688.63023903445;5836.153757705194;5989.52083833301;5993.910091348721;6008.24896887889;5908.143319218603;5945.791897283747;5967.8959392512525;5971.522278217819;5975.940240597538;5476.726163691879;5588.692621905834;5862.67755273447;5885.176075349369;5885.440883116097;5988.820335389771;5992.280926288873;6005.759769609167;6009.248843894513;6025.246844144482;5813.3605303417435;5843.415658434293;5896.380880007538;5902.4097590240635;5913.822585322448 08:57:06 INFO - PROCESS | 26579 | |5;yui.html;650.8112647332274;678.6030172349175;686.4611280145085;724.1382754522118;731.7768080735375;12838.293893835847;12962.93518532406;12964.286964216964;13036.15265007775;13066.934665326684;12947.741045179091;13106.344682765848;13191.34043297836;13199.274039927801;13218.60344189676;685.3078390825252;794.9920500794976;809.2676128104046;821.1706176761484;823.9670413183466;818.9918100819004;820.3847114664002;821.289584509401;823.045267489712;824.8350329934008;832.4089896173724;837.5602808525542;837.7109897085496;837.8533756592602;837.9581020948958;705.0376236437252;814.5479259011246;830.0827585518036;831.0526000359595;833.891594092767;608.0301918440081;608.1303735658007;608.3885694876665;611.807280706576;613.702354358136;12034.939825300906;12117.151799374047;12155.696107597292;12195.268283902995;12206.084543659172;12732.299723515203;12853.614391568268;12948.741025179537;13077.411516481781;13087.541936032194;10557.947210263976;10739.001912710803;10766.946165269124;10895.182861285435;11115.777684446346;4342.739435633841;4343.717658352229;4357.215701173787;4358.542353052915;4373.190959672439;52649.2102618461;52822.47177528214;53301.46698533043;53386.73306633442;53610.46389536094;9563.808723825485;9566.760830979281;9936.354136981074;10054.145397641283;10097.848532272023;17002.914985425243;17055.914720426317;17124.058176800394;17131;17167.31330746781;7582.772516824504;7743.148253692089;8074.273315401642;8162.14297498766;8227.177282271845;4442.777861106932;4717.9292310615365;4837.564619184291;4895.951040489621;4932.087563800708;3137.1686503076703;3211.309568442796;3220.500822372536;3233.224026233687;3247.4641684121857;569.5557465177169;593.1399470767404;615.5229696984783;661.5303134774268;683.1255992329826;578.890010897928;691.5815931361554;696.5785699651739;700.6286668065933;709.0781983421531;8644.91355086441;8831.337649676172;8974.910250897537;8994.86507702385;9162;581.834177259479;608.6986941464004;623.1587357067922;623.4420193926411;634.4226753654152;4217.240896638573;4261.74429534229;4335.523092459827;4399.780010999437;4410.448693913261;64176;65499.672501637186;65580.67209663922;65588;65872.67063664651;55540;57108.42891571114;57212;57780.422195778345;57866;53411.19883201755;53559;53693.73153134209;53699.46300537023;54799.178012329845;8400.87398689008;8467.407281490237;8499;8566.48601083937;8575.245234867254;34771.82614086913;34987.47518787169;35705.28589428249;35896.28207435889;36148;43799.781001094794;45860.54139458563;47683.28475072946;47815;48356;10536.57853685844;10554.736131596772;10711.41087240178;10949.288296260718;11050.281731687415;11619.535218591162;11759.835194708454;11851.940740296242;12107.878921210675;12291.201071930296;9819.459929703935;11087.944560277147;11365.204435689422;11598.71003224926;11834.230774999598;11115.666530004113;11160.21878468532;11367.829482557603;11506.367149806842;12061.939690301493;10572.524236409534;10594.788104238027;10901.34591924487;10920.617778377718;11162.944185279022;9919;10036.749081273027;10112.49437528106;10241.436720980417;10300.484975751333;9889.752756181153;10096.84854727165;10414.791704166026;10637.574497020032;10684.145268378355 08:57:06 INFO - PROCESS | 26579 | __end_tp_report 08:57:06 INFO - PROCESS | 26579 | __start_cc_report 08:57:06 INFO - PROCESS | 26579 | _x_x_mozilla_cycle_collect,843 08:57:06 INFO - PROCESS | 26579 | __end_cc_report 08:57:06 INFO - PROCESS | 26579 | __startTimestamp1460995026518__endTimestamp 08:57:06 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | ------- Summary: start ------- 08:57:06 INFO - PROCESS | 26579 | Number of tests: 6 08:57:06 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | [#0] dojo.html Cycles:165 Average:5213.59 Median:5413.92 stddev:581.58 (10.7%) stddev-sans-first:556.92 08:57:06 INFO - PROCESS | 26579 | Values: 3003.5 3048.2 3085.1 3094.2 3113.2 5191.6 5220.5 5225.1 5269.1 5269.3 5257.3 5307.8 5309.0 5324.4 5339.1 4735.8 4778.4 4869.6 4912.2 4939.9 4829.7 4867.5 4887.4 4890.5 4913.1 4731.9 4747.9 4773.4 4777.1 4784.5 4749.8 4795.0 4797.5 4802.5 4838.9 4681.5 4744.7 4762.1 4787.4 4813.5 5150.7 5173.0 5181.7 5191.4 5254.8 5511.5 5513.4 5516.6 5527.4 5529.8 5544.1 5582.6 5607.0 5651.1 5651.2 5158.4 5170.0 5178.7 5178.9 5231.9 5623.8 5639.2 5639.2 5644.0 5650.6 5407.7 5420.4 5468.1 5556.1 5580.7 5577.8 5614.9 5616.6 5619.2 5625.4 5581.3 5598.1 5601.9 5603.1 5605.3 5476.5 5562.4 5605.6 5636.3 5647.1 4254.6 4262.2 4267.0 4268.6 4298.4 3705.8 3818.8 3828.2 3849.8 3872.4 5303.1 5340.1 5343.8 5393.4 5394.4 5612.6 5657.3 5658.6 5666.3 5667.0 5186.2 5247.1 5292.9 5327.2 5398.7 4866.5 4883.1 4887.5 4904.9 4933.7 5835.3 5837.4 5838.1 5844.2 5888.2 5544.1 5639.4 5679.3 5682.9 5707.8 5728.9 5746.0 5746.8 5777.2 5795.7 5521.4 5521.4 5522.8 5524.9 5539.0 5482.7 5611.9 5628.9 5669.0 5715.7 5502.0 5522.8 5529.7 5530.0 5531.6 5500.1 5504.4 5505.3 5514.9 5562.3 5269.7 5334.4 5411.6 5427.2 5454.5 5478.2 5505.4 5513.7 5513.9 5519.0 5224.6 5357.8 5405.7 5413.9 5415.5 08:57:06 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | [#1] ext.html Cycles:180 Average:52161.63 Median:216898.00 stddev:97156.53 (44.8%) stddev-sans-first:97351.98 08:57:06 INFO - PROCESS | 26579 | Values: 611.6 645.1 658.1 674.8 677.9 32565.3 33453.2 33480.0 33505.3 33549.5 39136.0 40546.8 40684.4 40779.2 40800.2 8515.8 8756.0 8760.0 8761.0 8763.7 8596.4 8726.3 8730.8 8731.3 8731.5 8740.9 8837.6 8842.3 9037.0 9042.4 8832.6 8879.6 8897.2 8901.0 8987.6 8649.4 8772.1 8775.1 8853.2 8866.9 40073.0 40255.2 40320.2 40353.6 40389.8 3213.9 3395.7 3417.2 3431.3 3662.3 30580.5 31233.2 31443.2 31532.0 31750.7 4175.5 4265.2 4303.4 4314.2 4375.1 282610.0 283391.0 284581.0 285180.0 286244.0 57313.4 57463.7 57596.0 57754.4 57993.0 51605.7 51610.2 51618.0 51643.7 56184.2 16315.7 16989.1 17052.7 17065.9 17114.6 12398.9 12437.7 12470.3 12480.7 12481.1 15775.9 17256.5 17296.8 17505.5 17565.7 5846.7 6140.9 6226.7 6236.8 6316.8 1075.9 1086.9 1100.5 1182.1 1214.6 30994.0 32380.9 32545.8 32829.7 33475.8 1021.3 1067.7 1085.5 1126.9 1197.9 16824.9 17519.9 17546.5 17571.7 17691.6 394660.0 483445.0 494841.0 495069.0 495087.0 51685.7 52081.7 52327.5 52388.2 52463.2 1222.3 1264.7 1272.9 1285.9 1372.6 28196.4 29635.6 29698.6 30435.4 32203.4 46045.0 55065.7 56547.4 56715.7 57110.1 315275.0 315451.0 315662.0 317013.0 318137.0 26090.0 28218.4 28314.7 28923.7 28939.1 43327.1 43401.3 43486.1 44352.8 44412.8 36946.0 37413.4 37720.4 39063.6 39539.2 38310.0 39718.2 40307.4 40370.6 40791.8 39571.0 40155.4 41342.2 41374.0 41515.0 34348.7 35136.1 35188.3 36062.3 36159.6 27668.6 28123.2 28138.2 28223.3 28239.9 08:57:06 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | [#2] jquery.html Cycles:180 Average:27421.81 Median:2645.32 stddev:74862.71 (2830.0%) stddev-sans-first:75045.20 08:57:06 INFO - PROCESS | 26579 | Values: 389.8 394.4 398.1 399.5 407.6 14270.6 16539.5 18141.5 18655.5 18684.9 17396.0 17630.5 17817.1 17844.1 18222.5 5057.5 5175.8 5194.6 5197.5 5213.1 3851.7 5121.1 5169.4 5432.0 5751.3 5675.6 5703.9 5755.4 5757.3 5765.5 5686.8 6116.9 6364.7 6412.5 6431.4 5442.7 5573.6 5696.6 5704.5 5713.8 13249.0 13395.9 13441.6 13489.3 13499.9 2138.9 2222.9 2352.3 2372.2 2918.5 9204.9 9657.5 9767.4 9811.0 9932.8 1790.6 1839.7 1889.7 1891.1 1907.2 77867.6 80396.6 81273.6 81887.0 82421.2 10674.1 10884.1 10906.7 10985.4 10990.3 15412.9 15438.2 15466.0 15483.6 15483.9 8051.1 8210.4 8269.9 8420.4 8438.9 7881.0 7985.2 8011.9 8098.8 8111.6 4688.9 4745.4 4797.0 4808.5 4855.6 1782.5 1789.0 1876.9 1905.2 2045.0 977.6 991.5 1002.2 1109.9 1115.7 18097.0 18480.7 18958.8 19554.4 19673.0 1004.2 1011.7 1044.2 1106.0 1110.8 10533.2 10583.9 10652.1 10743.4 10744.9 418601.0 419791.0 455488.0 478719.0 483638.0 91432.5 92624.5 92971.5 96793.5 97878.0 1013.8 1021.9 1022.5 1035.6 1036.1 16232.8 16640.0 16845.1 16966.4 17145.4 37133.0 37440.6 38610.8 38868.8 40180.4 55484.7 55869.7 56997.4 57457.4 57629.0 8320.8 8377.9 8412.4 8462.1 8544.3 8822.7 11502.7 12534.2 13256.0 13308.3 11727.2 11809.3 11912.8 11982.0 12054.0 11491.1 11535.7 11602.8 11772.4 11868.7 12049.2 12180.5 12312.3 12426.9 12640.2 8227.8 8301.5 8341.7 8425.7 8499.9 11371.5 11836.6 11855.2 11882.7 11939.8 08:57:06 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | [#3] mootools.html Cycles:180 Average:5465.84 Median:5009.87 stddev:2977.30 (59.4%) stddev-sans-first:2969.03 08:57:06 INFO - PROCESS | 26579 | Values: 1279.6 1514.4 1533.7 1675.3 1811.3 7759.3 8037.0 8043.6 8043.8 8053.6 7807.5 7928.4 7935.4 7937.3 7942.6 2006.9 2264.4 2272.5 2301.2 2327.5 2303.4 2326.5 2327.4 2330.4 2331.7 2268.8 2303.3 2305.7 2306.0 2306.1 1942.9 2253.8 2319.9 2321.0 2323.3 2250.0 2252.9 2254.2 2254.8 2303.5 8100.5 8254.8 8290.5 8315.5 8326.3 4836.5 4991.1 5001.3 5035.2 5036.9 3362.5 3362.9 3422.0 3428.7 3432.7 1127.2 1127.8 1140.5 1159.6 1168.6 11059.9 11135.1 11151.7 11159.6 11183.9 4234.9 4322.3 4440.0 4445.6 4523.6 9396.4 9451.6 9467.6 9469.9 9480.8 4572.1 4946.3 4990.3 4995.9 5001.3 4497.8 4624.0 4626.2 4629.1 4647.3 3823.1 3836.3 3902.8 3924.5 3946.8 1298.8 1305.9 1306.0 1314.6 1323.8 745.2 854.4 901.3 907.2 916.9 5482.7 5573.0 5708.8 5784.5 5850.3 968.5 1069.6 1112.7 1117.2 1118.8 4131.7 4241.0 4299.7 4340.6 4380.1 9895.9 10093.2 10277.7 10282.6 10285.3 10009.1 10162.3 10191.7 10205.5 10214.7 7562.6 7711.2 7724.3 7901.4 7904.5 5828.6 5871.2 5908.0 6063.6 6064.2 9140.3 9238.5 9295.0 9318.6 9385.8 9576.0 9610.6 9615.0 9723.2 9738.5 6476.7 7001.3 7156.7 7177.2 7301.2 7610.5 7640.4 7688.1 7699.6 7717.1 6934.3 7057.0 7071.9 7135.5 7230.1 6813.2 6872.6 6889.0 6915.1 7088.7 6676.6 6682.0 6730.6 6733.6 6735.3 5075.7 5101.4 5122.0 5150.7 5193.0 5018.4 5020.2 5074.0 5149.4 5192.2 08:57:06 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | [#4] prototype.html Cycles:180 Average:4940.69 Median:5661.64 stddev:1454.27 (25.7%) stddev-sans-first:1416.63 08:57:06 INFO - PROCESS | 26579 | Values: 332.9 335.1 335.7 343.5 346.5 5606.0 5661.0 5662.3 5684.6 5705.6 5585.2 5600.4 5608.4 5621.2 5639.6 4140.5 4210.0 4335.2 4337.2 4368.6 4307.4 4316.9 4334.4 4354.8 4360.3 4117.0 4336.5 4351.3 4352.9 4368.2 4013.5 4259.4 4310.4 4323.7 4349.6 3827.4 3830.7 3833.7 3839.4 3850.5 5294.4 5400.5 5404.3 5411.3 5433.3 4987.1 5010.3 5011.3 5013.5 5028.4 5821.5 5842.5 5856.9 5859.7 5875.2 4062.2 4222.7 4227.5 4238.3 4253.4 6092.6 6095.3 6119.4 6127.2 6155.8 4294.3 4315.5 4330.4 4332.1 4342.0 4250.6 4353.5 4378.6 4380.3 4390.1 4944.8 4956.2 4971.0 5000.5 5010.7 5872.9 5912.6 5914.5 5914.9 5941.7 1494.1 1497.4 1520.2 1524.3 1525.3 978.0 1004.9 1033.8 1041.0 1045.8 5634.5 5689.3 5705.2 5714.9 5723.2 5997.9 6022.4 6029.3 6030.2 6061.4 5482.1 5640.8 5674.7 5677.0 5715.6 3128.7 3190.3 3190.7 3205.5 3221.6 5990.7 6140.4 6163.3 6169.0 6201.0 6059.4 6117.6 6125.8 6133.9 6150.1 6058.9 6156.4 6156.8 6171.4 6183.8 5870.5 5967.9 5974.3 5979.0 5984.3 5823.6 5833.6 5861.6 5879.9 5891.9 5910.2 6111.4 6113.0 6135.2 6169.8 4301.2 4302.5 4307.4 4317.3 4318.2 5912.7 5940.0 5967.3 5969.1 5979.5 5688.6 5836.2 5989.5 5993.9 6008.2 5908.1 5945.8 5967.9 5971.5 5975.9 5476.7 5588.7 5862.7 5885.2 5885.4 5988.8 5992.3 6005.8 6009.2 6025.2 5813.4 5843.4 5896.4 5902.4 5913.8 08:57:06 INFO - PROCESS | 26579 | 08:57:06 INFO - PROCESS | 26579 | [#5] yui.html Cycles:180 Average:14601.38 Median:26596.78 stddev:17780.37 (66.9%) stddev-sans-first:17799.39 08:57:06 INFO - PROCESS | 26579 | Values: 650.8 678.6 686.5 724.1 731.8 12838.3 12962.9 12964.3 13036.2 13066.9 12947.7 13106.3 13191.3 13199.3 13218.6 685.3 795.0 809.3 821.2 824.0 819.0 820.4 821.3 823.0 824.8 832.4 837.6 837.7 837.9 838.0 705.0 814.5 830.1 831.1 833.9 608.0 608.1 608.4 611.8 613.7 12034.9 12117.2 12155.7 12195.3 12206.1 12732.3 12853.6 12948.7 13077.4 13087.5 10557.9 10739.0 10766.9 10895.2 11115.8 4342.7 4343.7 4357.2 4358.5 4373.2 52649.2 52822.5 53301.5 53386.7 53610.5 9563.8 9566.8 9936.4 10054.1 10097.8 17002.9 17055.9 17124.1 17131.0 17167.3 7582.8 7743.1 8074.3 8162.1 8227.2 4442.8 4717.9 4837.6 4896.0 4932.1 3137.2 3211.3 3220.5 3233.2 3247.5 569.6 593.1 615.5 661.5 683.1 578.9 691.6 696.6 700.6 709.1 8644.9 8831.3 8974.9 8994.9 9162.0 581.8 608.7 623.2 623.4 634.4 4217.2 4261.7 4335.5 4399.8 4410.4 64176.0 65499.7 65580.7 65588.0 65872.7 55540.0 57108.4 57212.0 57780.4 57866.0 53411.2 53559.0 53693.7 53699.5 54799.2 8400.9 8467.4 8499.0 8566.5 8575.2 34771.8 34987.5 35705.3 35896.3 36148.0 43799.8 45860.5 47683.3 47815.0 48356.0 10536.6 10554.7 10711.4 10949.3 11050.3 11619.5 11759.8 11851.9 12107.9 12291.2 9819.5 11087.9 11365.2 11598.7 11834.2 11115.7 11160.2 11367.8 11506.4 12061.9 10572.5 10594.8 10901.3 10920.6 11162.9 9919.0 10036.7 10112.5 10241.4 10300.5 9889.8 10096.8 10414.8 10637.6 10684.1 08:57:06 INFO - PROCESS | 26579 | -------- Summary: end -------- 08:57:06 INFO - PROCESS | 26579 | 08:57:07 INFO - TEST-INFO | 26579: exit 0 08:57:07 INFO - TEST-OK | dromaeo_css | took 1110664ms 08:57:07 INFO - TEST-START | kraken 08:57:07 INFO - operating with platform_type : linux_ 08:57:07 INFO - Initialising browser for kraken test... 08:57:07 INFO - TEST-INFO | started process 26758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSCEJjK/profile http://localhost:39614/getInfo.html) 08:57:10 INFO - PROCESS | 26758 | __metrics Screen width/height:1600/1200 08:57:10 INFO - PROCESS | 26758 | colorDepth:24 08:57:10 INFO - PROCESS | 26758 | Browser inner width/height: 1024/697 08:57:10 INFO - PROCESS | 26758 | __metrics 08:57:11 ERROR - PROCESS | 26758 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:57:12 INFO - TEST-INFO | 26758: exit 0 08:57:12 INFO - Browser initialized. 08:57:12 INFO - Running cycle 1/1 for kraken test... 08:57:12 INFO - TEST-INFO | started process 26839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSCEJjK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:24 INFO - PROCESS | 26839 | RSS: Main: 153231360 08:57:24 INFO - PROCESS | 26839 | 08:57:26 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39614/tests/kraken/driver.html?testName=audio-beat-detection) 08:57:27 INFO - PROCESS | 26839 | RSS: Main: 208556032 08:57:27 INFO - PROCESS | 26839 | 08:57:30 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39614/tests/kraken/driver.html?testName=audio-dft) 08:57:30 INFO - PROCESS | 26839 | RSS: Main: 194215936 08:57:30 INFO - PROCESS | 26839 | 08:57:33 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39614/tests/kraken/driver.html?testName=audio-fft) 08:57:34 INFO - PROCESS | 26839 | RSS: Main: 264269824 08:57:34 INFO - PROCESS | 26839 | 08:57:36 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39614/tests/kraken/driver.html?testName=audio-oscillator) 08:57:37 INFO - PROCESS | 26839 | RSS: Main: 173211648 08:57:37 INFO - PROCESS | 26839 | 08:57:39 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39614/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:57:40 INFO - PROCESS | 26839 | RSS: Main: 177192960 08:57:40 INFO - PROCESS | 26839 | 08:57:43 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39614/tests/kraken/driver.html?testName=imaging-darkroom) 08:57:43 INFO - PROCESS | 26839 | RSS: Main: 213082112 08:57:43 INFO - PROCESS | 26839 | 08:57:46 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39614/tests/kraken/driver.html?testName=imaging-desaturate) 08:57:47 INFO - PROCESS | 26839 | RSS: Main: 214339584 08:57:47 INFO - PROCESS | 26839 | 08:57:50 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39614/tests/kraken/driver.html?testName=json-parse-financial) 08:57:50 INFO - PROCESS | 26839 | RSS: Main: 214200320 08:57:50 INFO - PROCESS | 26839 | 08:57:52 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39614/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:57:53 INFO - PROCESS | 26839 | RSS: Main: 203878400 08:57:53 INFO - PROCESS | 26839 | 08:57:54 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:57:55 INFO - PROCESS | 26839 | RSS: Main: 204038144 08:57:55 INFO - PROCESS | 26839 | 08:57:57 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:57:58 INFO - PROCESS | 26839 | RSS: Main: 218427392 08:57:58 INFO - PROCESS | 26839 | 08:58:00 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:01 INFO - PROCESS | 26839 | RSS: Main: 222457856 08:58:01 INFO - PROCESS | 26839 | 08:58:04 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:04 INFO - PROCESS | 26839 | RSS: Main: 219738112 08:58:04 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | Cycle 1(1): loaded http://localhost:39614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39614/tests/kraken/driver.html?testName=ai-astar) 08:58:06 INFO - PROCESS | 26839 | RSS: Main: 283074560 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | __start_tp_report 08:58:06 INFO - PROCESS | 26839 | _x_x_mozilla_page_load 08:58:06 INFO - PROCESS | 26839 | _x_x_mozilla_page_load_details 08:58:06 INFO - PROCESS | 26839 | |i|pagename|runs| 08:58:06 INFO - PROCESS | 26839 | |0;ai-astar;113;113;107;111;114;113;102;114;111;111 08:58:06 INFO - PROCESS | 26839 | |1;audio-beat-detection;160;129;158;198;133;160;173;128;201;127 08:58:06 INFO - PROCESS | 26839 | |2;audio-dft;163;162;161;161;161;161;163;163;163;162 08:58:06 INFO - PROCESS | 26839 | |3;audio-fft;72;74;104;109;74;76;74;138;113;73 08:58:06 INFO - PROCESS | 26839 | |4;audio-oscillator;92;93;152;92;92;93;142;92;93;150 08:58:06 INFO - PROCESS | 26839 | |5;imaging-gaussian-blur;118;117;117;117;118;118;117;117;116;117 08:58:06 INFO - PROCESS | 26839 | |6;imaging-darkroom;146;146;146;145;145;146;145;146;146;145 08:58:06 INFO - PROCESS | 26839 | |7;imaging-desaturate;95;95;95;95;95;95;94;94;95;95 08:58:06 INFO - PROCESS | 26839 | |8;json-parse-financial;56;57;56;56;57;58;56;69;55;54 08:58:06 INFO - PROCESS | 26839 | |9;json-stringify-tinderbox;62;62;60;61;61;60;60;61;61;61 08:58:06 INFO - PROCESS | 26839 | |10;stanford-crypto-aes;77;77;76;84;77;77;78;79;78;78 08:58:06 INFO - PROCESS | 26839 | |11;stanford-crypto-ccm;122;123;128;149;124;125;119;123;161;126 08:58:06 INFO - PROCESS | 26839 | |12;stanford-crypto-pbkdf2;169;170;165;166;167;167;165;167;167;165 08:58:06 INFO - PROCESS | 26839 | |13;stanford-crypto-sha256-iterative;68;68;68;67;67;66;69;66;69;67 08:58:06 INFO - PROCESS | 26839 | __end_tp_report 08:58:06 INFO - PROCESS | 26839 | __start_cc_report 08:58:06 INFO - PROCESS | 26839 | _x_x_mozilla_cycle_collect,1661 08:58:06 INFO - PROCESS | 26839 | __end_cc_report 08:58:06 INFO - PROCESS | 26839 | __startTimestamp1460995086601__endTimestamp 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | ------- Summary: start ------- 08:58:06 INFO - PROCESS | 26839 | Number of tests: 14 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#0] ai-astar Cycles:10 Average:110.90 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:3.91 08:58:06 INFO - PROCESS | 26839 | Values: 113.0 113.0 107.0 111.0 114.0 113.0 102.0 114.0 111.0 111.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:160.00 stddev:27.87 (17.4%) stddev-sans-first:29.54 08:58:06 INFO - PROCESS | 26839 | Values: 160.0 129.0 158.0 198.0 133.0 160.0 173.0 128.0 201.0 127.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 08:58:06 INFO - PROCESS | 26839 | Values: 163.0 162.0 161.0 161.0 161.0 161.0 163.0 163.0 163.0 162.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#3] audio-fft Cycles:10 Average:90.70 Median:73.50 stddev:23.48 (31.9%) stddev-sans-first:23.91 08:58:06 INFO - PROCESS | 26839 | Values: 72.0 74.0 104.0 109.0 74.0 76.0 74.0 138.0 113.0 73.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:26.96 (29.3%) stddev-sans-first:27.88 08:58:06 INFO - PROCESS | 26839 | Values: 92.0 93.0 152.0 92.0 92.0 93.0 142.0 92.0 93.0 150.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 08:58:06 INFO - PROCESS | 26839 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 116.0 117.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:58:06 INFO - PROCESS | 26839 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:58:06 INFO - PROCESS | 26839 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.50 stddev:4.22 (7.5%) stddev-sans-first:4.45 08:58:06 INFO - PROCESS | 26839 | Values: 56.0 57.0 56.0 56.0 57.0 58.0 56.0 69.0 55.0 54.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 08:58:06 INFO - PROCESS | 26839 | Values: 62.0 62.0 60.0 61.0 61.0 60.0 60.0 61.0 61.0 61.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:2.23 (2.9%) stddev-sans-first:2.33 08:58:06 INFO - PROCESS | 26839 | Values: 77.0 77.0 76.0 84.0 77.0 77.0 78.0 79.0 78.0 78.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:125.50 stddev:13.69 (10.9%) stddev-sans-first:14.21 08:58:06 INFO - PROCESS | 26839 | Values: 122.0 123.0 128.0 149.0 124.0 125.0 119.0 123.0 161.0 126.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:1.69 (1.0%) stddev-sans-first:1.59 08:58:06 INFO - PROCESS | 26839 | Values: 169.0 170.0 165.0 166.0 167.0 167.0 165.0 167.0 167.0 165.0 08:58:06 INFO - PROCESS | 26839 | 08:58:06 INFO - PROCESS | 26839 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 08:58:06 INFO - PROCESS | 26839 | Values: 68.0 68.0 68.0 67.0 67.0 66.0 69.0 66.0 69.0 67.0 08:58:06 INFO - PROCESS | 26839 | -------- Summary: end -------- 08:58:06 INFO - PROCESS | 26839 | 08:58:07 INFO - TEST-INFO | 26839: exit 0 08:58:07 INFO - TEST-OK | kraken | took 60397ms 08:58:07 INFO - SUITE-END | took 1171s 08:58:07 INFO - Completed test suite (00:19:31) 08:58:07 INFO - javascript benchmark 08:58:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3003.5344521599154, 3048.1922290592984, 3085.089898479947, 3094.2109762010696, 3113.2216945763553, 5191.636585439021, 5220.504052115052, 5225.0856100182455, 5269.077911365515, 5269.288646032789, 5257.342832145981, 5307.840764777054, 5309.0, 5324.41431442541, 5339.06566350889, 4735.834245801398, 4778.402699662533, 4869.586085182746, 4912.189488734354, 4939.925901111486, 4829.6860704054125, 4867.537583929521, 4887.364642596457, 4890.462049174588, 4913.115639184945, 4731.881702957419, 4747.857564273095, 4773.427188737373, 4777.09235245304, 4784.545468180518, 4749.786259618326, 4795.0, 4797.544233297831, 4802.471728109905, 4838.927416088762, 4681.5318468153255, 4744.691595046311, 4762.095201911626, 4787.449443314029, 4813.470518242991, 5150.742462876841, 5173.042987047371, 5181.740912954338, 5191.402988656315, 5254.789808407659, 5511.5039646432015, 5513.448655134494, 5516.558675305966, 5527.419620939783, 5529.806456773994, 5544.140658197985, 5582.637128586629, 5606.971965140189, 5651.06757385031, 5651.208830763655, 5158.432572417031, 5169.974150129226, 5178.741062946838, 5178.948210517884, 5231.921521177185, 5623.775048998076, 5639.154126881001, 5639.210510528447, 5643.971780141073, 5650.63270887391, 5407.729613519308, 5420.430854760193, 5468.125099983983, 5556.138798486241, 5580.693061881554, 5577.8047768327915, 5614.9438505615235, 5616.5787565931905, 5619.185218143346, 5625.437456254342, 5581.302337207849, 5598.076317407664, 5601.887962240732, 5603.131514615241, 5605.271314729059, 5476.507114359647, 5562.360328562268, 5605.607607467438, 5636.323641163087, 5647.124695672177, 4254.595813397722, 4262.23279809631, 4267.039916018871, 4268.59448352406, 4298.376735373354, 3705.8332375043187, 3818.809059547067, 3828.2152158807376, 3849.7882616455804, 3872.4191371294532, 5303.098473259478, 5340.118880384693, 5343.759530821122, 5393.352797664227, 5394.406615272317, 5612.579056570774, 5657.2928383952, 5658.603897727202, 5666.320041594952, 5667.0, 5186.222066690027, 5247.081760691864, 5292.92060619091, 5327.174287985368, 5398.703071331114, 4866.537678920497, 4883.096627123993, 4887.511248875084, 4904.926426103611, 4933.654644174945, 5835.328937172279, 5837.357890632027, 5838.1242813577455, 5844.181814545882, 5888.234529511136, 5544.085225937675, 5639.436056394492, 5679.261695979496, 5682.886342273214, 5707.771689132388, 5728.856778580569, 5745.971270143623, 5746.7701291949525, 5777.191193233035, 5795.710214489174, 5521.3926468087675, 5521.4478552144465, 5522.834314970557, 5524.944750552443, 5539.0, 5482.698451585201, 5611.943880561143, 5628.859278517906, 5669.0, 5715.657060576379, 5502.0371434997915, 5522.779088836402, 5529.723513824212, 5530.004599172027, 5531.557475401878, 5500.119980803052, 5504.422035686195, 5505.311836020497, 5514.889702206014, 5562.332520097452, 5269.657472264291, 5334.413214546475, 5411.594130440154, 5427.213054107211, 5454.509094181542, 5478.178273258884, 5505.394406615349, 5513.724313784375, 5513.862153446196, 5518.972405138109, 5224.634275600672, 5357.8392648220615, 5405.729713514387, 5413.918791218213, 5415.48552887475], "value": 5174.913930902113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.5902345428563, 645.1129696667083, 658.0688326018685, 674.7537148940638, 677.8881484555052, 32565.348693026153, 33453.16367090818, 33480.0, 33505.329893402115, 33549.49675754866, 39136.0, 40546.7972660137, 40684.389734154014, 40779.184416311655, 40800.183996320055, 8515.829683406328, 8756.03683594804, 8760.036395996436, 8761.0, 8763.737087887343, 8596.398252122353, 8726.345524085687, 8730.781730456725, 8731.34514911381, 8731.519766412845, 8740.912590874073, 8837.64649414026, 8842.29261659069, 9037.0, 9042.367034307601, 8832.602532886003, 8879.556022198929, 8897.199252067312, 8900.955495222515, 8987.55062246885, 8649.351298652626, 8772.078931712205, 8775.078616745213, 8853.24747396472, 8866.911330886738, 40073.0, 40255.194896102206, 40320.19359612821, 40353.596464035276, 40389.79805100956, 3213.9196520087185, 3395.6604339565847, 3417.2140407706365, 3431.2965842002577, 3662.267546490686, 30580.54129188064, 31233.219169520944, 31443.213919651964, 31532.0, 31750.682493175234, 4175.54069052404, 4265.189613973335, 4303.392138378911, 4314.158739045887, 4375.12497500498, 282610.0, 283391.0, 284581.0, 285180.0, 286244.0, 57313.426865730806, 57463.71268143632, 57596.0, 57754.422455774904, 57993.0, 51605.741971289906, 51610.22584661233, 51618.0, 51643.74178129085, 56184.15723764147, 16315.673686526203, 16989.06560139204, 17052.658946820993, 17065.91467042657, 17114.572135696708, 12398.876011239772, 12437.689057773447, 12470.251784892935, 12480.687982800502, 12481.126321157431, 15775.921120394325, 17256.482305530855, 17296.82703172952, 17505.474835754947, 17565.736513952303, 5846.678432686158, 6140.8771824564155, 6226.719797609118, 6236.844078898064, 6316.842078948063, 1075.8841707679933, 1086.896744809242, 1100.5487750022453, 1182.0602620916393, 1214.6416807041944, 30994.0, 32380.866669666448, 32545.837270813496, 32829.67170328314, 33475.83262083674, 1021.3004092196869, 1067.6743593203992, 1085.478970094359, 1126.8929451702074, 1197.874223206568, 16824.915875420545, 17519.91240043817, 17546.473605791845, 17571.714940882248, 17691.557711057325, 394660.0, 483445.0, 494841.0, 495069.0, 495087.0, 51685.7415712919, 52081.73959130256, 52327.47672523302, 52388.214176787376, 52463.213051804254, 1222.2544248008708, 1264.6964728465102, 1272.923624582528, 1285.8521270053877, 1372.5950844500896, 28196.43607127887, 29635.555466668447, 29698.554521682625, 30435.391292174474, 32203.35593288168, 46045.0, 55065.72467137639, 56547.434525654215, 56715.71642141763, 57110.143347848985, 315275.0, 315451.0, 315662.0, 317013.0, 318137.0, 26090.0, 28218.43563128767, 28314.716852832033, 28923.7107628921, 28939.131826045254, 43327.13345733131, 43401.3489797647, 43486.13027739491, 44352.778236108614, 44412.77793611011, 36946.0, 37413.438798417505, 37720.43419348767, 39063.60936390713, 39539.209215816096, 38310.0, 39718.2056358877, 40307.3953890686, 40370.59629403668, 40791.7960410196, 39571.0, 40155.397669034406, 41342.1731565361, 41373.96565085897, 41514.962125947095, 34348.656513434544, 35136.12159696028, 35188.296234075686, 36062.278754425286, 36159.63840361563, 27668.584971225046, 28123.156305310873, 28138.155855324374, 28223.31878471542, 28239.858800706686], "value": 19147.742375660226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.7525071579547, 394.38869751884573, 398.0685196639862, 399.4966342408565, 407.5639066199168, 14270.643233919158, 16539.503814885542, 18141.546461338457, 18655.5336116597, 18684.90657546712, 17396.0, 17630.47108586741, 17817.109144542785, 17844.10779461028, 18222.544436389097, 5057.519535644117, 5175.767090480918, 5194.558462530689, 5197.480251974791, 5213.139831927746, 3851.691864650835, 5121.129408000649, 5169.379674439073, 5432.0, 5751.309842818868, 5675.631083979549, 5703.885922281552, 5755.366909639936, 5757.280339957505, 5765.538756899438, 5686.772529098831, 6116.877662446748, 6364.745410183587, 6412.519061070392, 6431.421172094534, 5442.727863606804, 5573.554115670737, 5696.629719068289, 5704.458076482728, 5713.771449142029, 13249.0, 13395.933020334933, 13441.596752097452, 13489.325533723275, 13499.865001350057, 2138.9465263368384, 2222.922197723088, 2352.282553821084, 2372.15788395119, 2918.4746745585785, 9204.861927071099, 9657.517124143835, 9767.365121267096, 9811.0, 9932.751681207956, 1790.6239689665185, 1839.6964500857343, 1889.6504146732898, 1891.0711074703863, 1907.246637578149, 77867.61066194689, 80396.59801700954, 81273.59363203264, 81887.0, 82421.17578824195, 10674.146068314516, 10884.07485363737, 10906.672799816019, 10985.395803230898, 10990.340579565252, 15412.922935385252, 15438.150901700514, 15466.0, 15483.612909677347, 15483.922580387027, 8051.114377418479, 8210.425270231026, 8269.875951860728, 8420.410571259952, 8438.873416898752, 7880.960595196987, 7985.201479852085, 8011.919880801117, 8098.83802323962, 8111.594420278962, 4688.929666055012, 4745.3593764842, 4797.040591881638, 4808.471068182497, 4855.562999330077, 1782.5454509100355, 1788.9552761181073, 1876.9343072992654, 1905.1902941249914, 2044.9693254601193, 977.5600979559226, 991.4745185051934, 1002.1782138646386, 1109.909981717358, 1115.6987613344352, 18097.0, 18480.722789158175, 18958.81041189598, 19554.413367598994, 19673.0, 1004.1966426858484, 1011.6964910526813, 1044.1698849414734, 1105.9668209953713, 1110.8111621024445, 10533.157347412189, 10583.947080264703, 10652.147828173727, 10743.355398675949, 10744.892551074545, 418601.0, 419791.0, 455488.0, 478719.0, 483638.0, 91432.5428372854, 92624.53687731519, 92971.53514232521, 96793.5160324208, 97878.0, 1013.7871047080048, 1021.877374715039, 1022.4887556221889, 1035.5547114740734, 1036.0727149201423, 16232.837671623132, 16640.0, 16845.062817776114, 16966.406175783788, 17145.399911003056, 37133.0, 37440.59267542642, 38610.80694596509, 38868.80565597154, 40180.39729404003, 55484.72257638686, 55869.720651396485, 56997.43002570087, 57457.425425745205, 57629.0, 8320.750377488685, 8377.916220837957, 8412.369072319723, 8462.111478294937, 8544.273736732199, 8822.707214312853, 11502.654920352403, 12534.185277956904, 13256.0, 13308.268045257604, 11727.237729547553, 11809.291442513477, 11912.821307680219, 11982.0, 12054.0, 11491.138164637518, 11535.711607209887, 11602.767944640891, 11772.411379430823, 11868.703282418008, 12049.216800907912, 12180.45187966526, 12312.26126432417, 12426.875731242571, 12640.178388404724, 8227.83544329122, 8301.501909885426, 8341.708040218806, 8425.662973481238, 8499.915000849913, 11371.545138194711, 11836.58571950012, 11855.229410088317, 11882.702932426759, 11939.82090268664], "value": 8944.12281311164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.577739346016, 1514.409380341667, 1533.7239296926555, 1675.279629759203, 1811.266437092977, 7759.262870027345, 8037.0, 8043.55760433176, 8043.79890502737, 8053.637586308616, 7807.453478256524, 7928.445008849369, 7935.4048446366605, 7937.325327347183, 7942.563159026251, 2006.8695534790193, 2264.388615073929, 2272.4659704969317, 2301.2060839010514, 2327.4763178284834, 2303.389601755536, 2326.5230627721276, 2327.429779703975, 2330.4057465346395, 2331.73185083715, 2268.7844654757773, 2303.2744685424123, 2305.700258966332, 2306.0, 2306.1351993002622, 1942.9125689344014, 2253.7971582557566, 2319.884005799703, 2320.9883950580224, 2323.3378487131085, 2249.966250506244, 2252.8986195621237, 2254.1546919905036, 2254.751977282514, 2303.470201853583, 8100.473469224482, 8254.752357429286, 8290.46112002724, 8315.459495132858, 8326.2506374426, 4836.540528649773, 4991.07665081961, 5001.299818025443, 5035.194368900959, 5036.874078148076, 3362.4620060790157, 3362.882299119519, 3421.9657803421896, 3428.7257019438384, 3432.6910578048096, 1127.1715289262468, 1127.787628299573, 1140.5380820767602, 1159.6463078760974, 1168.5559487394821, 11059.944700276446, 11135.10919126476, 11151.665450036511, 11159.553617855276, 11183.888161118448, 4234.87295381139, 4322.265214913472, 4439.977800110979, 4445.599896009375, 4523.592876641118, 9396.436213827192, 9451.621935122517, 9467.621295148117, 9469.905300946903, 9480.762980925394, 4572.0627271409285, 4946.258061290835, 4990.30135780991, 4995.925061124086, 5001.299818025479, 4497.820087196541, 4624.0, 4626.236670949255, 4629.0973260214605, 4647.34937108805, 3823.0824602095295, 3836.271108489378, 3902.804859757001, 3924.47019652349, 3946.7631942082994, 1298.7597294500547, 1305.9151155174884, 1305.9542915997895, 1314.6450458376376, 1323.7881938889732, 745.2063552316765, 854.448880472092, 901.2609660078673, 907.1654078248027, 916.9495677737789, 5482.725863706799, 5573.0, 5708.771649134072, 5784.4504772046585, 5850.3272123705465, 968.5012218707371, 1069.6042464288264, 1112.67732357617, 1117.1677100559973, 1118.8377685235757, 4131.710780245414, 4241.0, 4299.656027517791, 4340.565943405634, 4380.058287468146, 9895.901040989642, 10093.24300677452, 10277.691669249934, 10282.588696452207, 10285.2800303978, 10009.099181073738, 10162.339447935861, 10191.7452063699, 10205.489725513695, 10214.693559193236, 7562.584057876869, 7711.190325015905, 7724.3434308083315, 7901.446898717035, 7904.525728456311, 5828.562857785599, 5871.236739223874, 5908.0, 6063.636181829104, 6064.211652485149, 9140.314476414429, 9238.491882946502, 9295.0, 9318.580663870007, 9385.812283754423, 9576.0, 9610.615575377185, 9614.95192524033, 9723.201207776585, 9738.464384458923, 6476.708548115252, 7001.264867189076, 7156.749513766993, 7177.174624917992, 7301.233370496021, 7610.467267291237, 7640.426967977535, 7688.115866675404, 7699.615019249127, 7717.073951125901, 6934.271901450275, 7057.0472986146215, 7071.858562828817, 7135.5361901476235, 7230.13238411394, 6813.182418109858, 6872.587644741331, 6889.035535025, 6915.101036865175, 7088.716451341888, 6676.632785196861, 6681.966590167018, 6730.596164230162, 6733.595984240961, 6735.259121496533, 5075.670081444694, 5101.362329708786, 5122.0, 5150.665206761549, 5193.039287731782, 5018.44797072329, 5020.171671674133, 5073.974630126826, 5149.382074151126, 5192.221166825007], "value": 4454.334791035022, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9117783787297, 335.11863798210703, 335.6878103363871, 343.5190732973838, 346.4941185868632, 5606.0, 5660.971695141524, 5662.310402558787, 5684.573656975723, 5705.5720820938495, 5585.162225666152, 5600.383957764642, 5608.411116832735, 5621.184928185421, 5639.605227634067, 4140.482439695038, 4209.957900421003, 4335.241332766769, 4337.240982828008, 4368.58498442649, 4307.353896915472, 4316.920769807548, 4334.371516130175, 4354.825806967718, 4360.324149756792, 4116.97941510292, 4336.522982471925, 4351.325544540601, 4352.912941741163, 4368.213721530124, 4013.4782478277784, 4259.382389553512, 4310.396544483775, 4323.675724320657, 4349.586789255048, 3827.3876179811095, 3830.6743926766258, 3833.677381303474, 3839.4432807242792, 3850.5186851643543, 5294.41761406245, 5400.513953744143, 5404.297441332641, 5411.323584551931, 5433.266509021271, 4987.127252730757, 5010.348654674905, 5011.3485246918035, 5013.523715247045, 5028.446870844205, 5821.50517206038, 5842.503387212092, 5856.912146317809, 5859.6777177255235, 5875.236219291465, 4062.2078694654556, 4222.683298752575, 4227.471566054243, 4238.3430568261965, 4253.404523366731, 6092.603980741238, 6095.2685677718955, 6119.44924956756, 6127.203463549755, 6155.815325540241, 4294.26997410441, 4315.546867578922, 4330.415393921843, 4332.133573285356, 4341.9565804341555, 4250.577171012494, 4353.49934757507, 4378.598848368491, 4380.255356589388, 4390.100029493946, 4944.7638090477385, 4956.207006878882, 4970.980948905466, 5000.499950004971, 5010.670038432147, 5872.941270587239, 5912.645241285537, 5914.467697907123, 5914.940850591525, 5941.70291485424, 1494.133402626474, 1497.4010395841533, 1520.1791032842361, 1524.291204589871, 1525.2678714217238, 977.9559919803626, 1004.924630652704, 1033.7777377863795, 1040.9843852342221, 1045.7751583409452, 5634.464725851038, 5689.34572524165, 5705.174344209813, 5714.942850571441, 5723.227364305849, 5997.880042399128, 6022.36765139654, 6029.306629737636, 6030.185924900083, 6061.424164704346, 5482.122860342326, 5640.7743690252755, 5674.716264186774, 5677.0, 5715.628484148517, 3128.749700023993, 3190.2502911815704, 3190.6649801770945, 3205.5031470122167, 3221.5650887130405, 5990.7304171311525, 6140.385961403824, 6163.291221509494, 6168.9691551541955, 6200.968995154995, 6059.394060593993, 6117.571769976148, 6125.785597504066, 6133.902379298425, 6150.138980542728, 6058.909116363258, 6156.384361563897, 6156.846078848064, 6171.444569988633, 6183.81448556544, 5870.471657550841, 5967.850803729942, 5974.312954010345, 5978.970105149447, 5984.341722410619, 5823.5923485355615, 5833.620814647034, 5861.6189947653265, 5879.941200587939, 5891.852703682443, 5910.23166988306, 6111.388861113853, 6113.0, 6135.233095863017, 6169.84575385619, 4301.182775272689, 4302.526722060508, 4307.440032795716, 4317.309230523101, 4318.201132790444, 5912.704364781658, 5939.990201665813, 5967.254093238345, 5969.104634304889, 5979.4618484336615, 5688.63023903445, 5836.153757705194, 5989.52083833301, 5993.910091348721, 6008.24896887889, 5908.143319218603, 5945.791897283747, 5967.8959392512525, 5971.522278217819, 5975.940240597538, 5476.726163691879, 5588.692621905834, 5862.67755273447, 5885.176075349369, 5885.440883116097, 5988.820335389771, 5992.280926288873, 6005.759769609167, 6009.248843894513, 6025.246844144482, 5813.3605303417435, 5843.415658434293, 5896.380880007538, 5902.4097590240635, 5913.822585322448], "value": 4475.233098426732, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.8112647332274, 678.6030172349175, 686.4611280145085, 724.1382754522118, 731.7768080735375, 12838.293893835847, 12962.93518532406, 12964.286964216964, 13036.15265007775, 13066.934665326684, 12947.741045179091, 13106.344682765848, 13191.34043297836, 13199.274039927801, 13218.60344189676, 685.3078390825252, 794.9920500794976, 809.2676128104046, 821.1706176761484, 823.9670413183466, 818.9918100819004, 820.3847114664002, 821.289584509401, 823.045267489712, 824.8350329934008, 832.4089896173724, 837.5602808525542, 837.7109897085496, 837.8533756592602, 837.9581020948958, 705.0376236437252, 814.5479259011246, 830.0827585518036, 831.0526000359595, 833.891594092767, 608.0301918440081, 608.1303735658007, 608.3885694876665, 611.807280706576, 613.702354358136, 12034.939825300906, 12117.151799374047, 12155.696107597292, 12195.268283902995, 12206.084543659172, 12732.299723515203, 12853.614391568268, 12948.741025179537, 13077.411516481781, 13087.541936032194, 10557.947210263976, 10739.001912710803, 10766.946165269124, 10895.182861285435, 11115.777684446346, 4342.739435633841, 4343.717658352229, 4357.215701173787, 4358.542353052915, 4373.190959672439, 52649.2102618461, 52822.47177528214, 53301.46698533043, 53386.73306633442, 53610.46389536094, 9563.808723825485, 9566.760830979281, 9936.354136981074, 10054.145397641283, 10097.848532272023, 17002.914985425243, 17055.914720426317, 17124.058176800394, 17131.0, 17167.31330746781, 7582.772516824504, 7743.148253692089, 8074.273315401642, 8162.14297498766, 8227.177282271845, 4442.777861106932, 4717.9292310615365, 4837.564619184291, 4895.951040489621, 4932.087563800708, 3137.1686503076703, 3211.309568442796, 3220.500822372536, 3233.224026233687, 3247.4641684121857, 569.5557465177169, 593.1399470767404, 615.5229696984783, 661.5303134774268, 683.1255992329826, 578.890010897928, 691.5815931361554, 696.5785699651739, 700.6286668065933, 709.0781983421531, 8644.91355086441, 8831.337649676172, 8974.910250897537, 8994.86507702385, 9162.0, 581.834177259479, 608.6986941464004, 623.1587357067922, 623.4420193926411, 634.4226753654152, 4217.240896638573, 4261.74429534229, 4335.523092459827, 4399.780010999437, 4410.448693913261, 64176.0, 65499.672501637186, 65580.67209663922, 65588.0, 65872.67063664651, 55540.0, 57108.42891571114, 57212.0, 57780.422195778345, 57866.0, 53411.19883201755, 53559.0, 53693.73153134209, 53699.46300537023, 54799.178012329845, 8400.87398689008, 8467.407281490237, 8499.0, 8566.48601083937, 8575.245234867254, 34771.82614086913, 34987.47518787169, 35705.28589428249, 35896.28207435889, 36148.0, 43799.781001094794, 45860.54139458563, 47683.28475072946, 47815.0, 48356.0, 10536.57853685844, 10554.736131596772, 10711.41087240178, 10949.288296260718, 11050.281731687415, 11619.535218591162, 11759.835194708454, 11851.940740296242, 12107.878921210675, 12291.201071930296, 9819.459929703935, 11087.944560277147, 11365.204435689422, 11598.71003224926, 11834.230774999598, 11115.666530004113, 11160.21878468532, 11367.829482557603, 11506.367149806842, 12061.939690301493, 10572.524236409534, 10594.788104238027, 10901.34591924487, 10920.617778377718, 11162.944185279022, 9919.0, 10036.749081273027, 10112.49437528106, 10241.436720980417, 10300.484975751333, 9889.752756181153, 10096.84854727165, 10414.791704166026, 10637.574497020032, 10684.145268378355], "value": 6442.944192126376, "unit": "score"}], "name": "dromaeo_css", "value": 6961.679476794692, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 107.0, 111.0, 114.0, 113.0, 102.0, 114.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 158.0, 198.0, 133.0, 160.0, 173.0, 128.0, 201.0, 127.0], "value": 156.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 163.0, 163.0, 163.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 104.0, 109.0, 74.0, 76.0, 74.0, 138.0, 113.0, 73.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 92.0, 92.0, 93.0, 142.0, 92.0, 93.0, 150.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 57.0, 58.0, 56.0, 69.0, 55.0, 54.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 60.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 84.0, 77.0, 77.0, 78.0, 79.0, 78.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 128.0, 149.0, 124.0, 125.0, 119.0, 123.0, 161.0, 126.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 165.0, 166.0, 167.0, 167.0, 165.0, 167.0, 167.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 66.0, 69.0, 66.0, 69.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1547.7, "alertThreshold": 2.0}]} 08:58:07 INFO - Return code: 0 08:58:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:58:07 ERROR - # TBPL SUCCESS # 08:58:07 INFO - Running post-action listener: _resource_record_post_action 08:58:07 INFO - Running post-run listener: _resource_record_post_run 08:58:08 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 480555008; Read time: 0; Write time: 374948 08:58:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 193298432; Read time: 0; Write time: 170036 08:58:08 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 287256576; Read time: 0; Write time: 204912 08:58:08 INFO - Running post-run listener: _upload_blobber_files 08:58:08 INFO - Blob upload gear active. 08:58:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:08 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 08:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:58:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:58:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:10 INFO - (blobuploader) - INFO - Done attempting. 08:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:11 INFO - (blobuploader) - INFO - Done attempting. 08:58:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:11 INFO - Return code: 0 08:58:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea77a1f3f7f118c6f5626b29c901c757ea9794e78165987ef6ea7c6f6c68abfd4279d4972fbb67bbf590664182bca37c9c0e6c514d032651017db7c12bc38809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/059a9cdd0ff7e91997e54940bad1049cf76681057bad469ac1eabaa02f0f44082e8d912f4fe2758294ec181c39b13da3c97c744c8fa9a547a675bba3a576cad4"} 08:58:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:11 INFO - Contents: 08:58:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea77a1f3f7f118c6f5626b29c901c757ea9794e78165987ef6ea7c6f6c68abfd4279d4972fbb67bbf590664182bca37c9c0e6c514d032651017db7c12bc38809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/059a9cdd0ff7e91997e54940bad1049cf76681057bad469ac1eabaa02f0f44082e8d912f4fe2758294ec181c39b13da3c97c744c8fa9a547a675bba3a576cad4"} 08:58:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:11 INFO - Copying logs to upload dir... 08:58:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.134563 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-18 08:58:10.338690) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 08:58:10.342482) ========= 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=1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea77a1f3f7f118c6f5626b29c901c757ea9794e78165987ef6ea7c6f6c68abfd4279d4972fbb67bbf590664182bca37c9c0e6c514d032651017db7c12bc38809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/059a9cdd0ff7e91997e54940bad1049cf76681057bad469ac1eabaa02f0f44082e8d912f4fe2758294ec181c39b13da3c97c744c8fa9a547a675bba3a576cad4"} build_url:https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/aeCUJ_I9SNGjWmyKciWV8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea77a1f3f7f118c6f5626b29c901c757ea9794e78165987ef6ea7c6f6c68abfd4279d4972fbb67bbf590664182bca37c9c0e6c514d032651017db7c12bc38809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/059a9cdd0ff7e91997e54940bad1049cf76681057bad469ac1eabaa02f0f44082e8d912f4fe2758294ec181c39b13da3c97c744c8fa9a547a675bba3a576cad4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 08:58:10.367606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:58:10.367930) ========= 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=1f5564757af27664ca02d71f000001b0-1460993704.904880-567353084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:58:10.449705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 08:58:10.450027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 08:58:10.450300) ========= ========= Total master_lag: 0.17 =========