builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1464195449.09 results: success (0) buildid: 20160525072441 builduid: b83e0d635e784aa5adb2c3d241f93675 revision: c4cf7fcd62d3cb5f1e2f5f7f0227459415017771 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.091668) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.092125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.092397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.111665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.112031) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 09:57:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 226M=0s 2016-05-25 09:57:29 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.229325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.229634) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013598 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.282220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:29.282528) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c4cf7fcd62d3cb5f1e2f5f7f0227459415017771 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c4cf7fcd62d3cb5f1e2f5f7f0227459415017771 --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=5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 09:57:29,829 truncating revision to first 12 chars 2016-05-25 09:57:29,829 Setting DEBUG logging. 2016-05-25 09:57:29,829 attempt 1/10 2016-05-25 09:57:29,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c4cf7fcd62d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 09:57:30,210 unpacking tar archive at: mozilla-beta-c4cf7fcd62d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.777165 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:30.075832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:30.076147) ========= script_repo_revision: c4cf7fcd62d3cb5f1e2f5f7f0227459415017771 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:30.076542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:30.076833) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 09:57:30.086831) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-25 09:57:30.087183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:30 INFO - MultiFileLogger online at 20160525 09:57:30 in /builds/slave/test 09:57:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:57:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:30 INFO - {'append_to_log': False, 09:57:30 INFO - 'base_work_dir': '/builds/slave/test', 09:57:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:57:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:30 INFO - 'branch': 'Mozilla-Beta', 09:57:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:30 INFO - 'config_files': ('talos/linux_config.py',), 09:57:30 INFO - 'default_actions': ('clobber', 09:57:30 INFO - 'read-buildbot-config', 09:57:30 INFO - 'download-and-extract', 09:57:30 INFO - 'populate-webroot', 09:57:30 INFO - 'create-virtualenv', 09:57:30 INFO - 'install', 09:57:30 INFO - 'run-tests'), 09:57:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:30 INFO - 'download_minidump_stackwalk': True, 09:57:30 INFO - 'download_symbols': 'ondemand', 09:57:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:30 INFO - 'installer_path': 'installer.exe', 09:57:30 INFO - 'log_level': 'info', 09:57:30 INFO - 'log_name': 'talos', 09:57:30 INFO - 'log_to_console': True, 09:57:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:30 INFO - 'opt_config_files': (), 09:57:30 INFO - 'pip_index': False, 09:57:30 INFO - 'sps_profile': False, 09:57:30 INFO - 'sps_profile_interval': 0, 09:57:30 INFO - 'suite': 'dromaeojs', 09:57:30 INFO - 'system_bits': '32', 09:57:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:30 INFO - 'title': 'talos-linux64-ix-011', 09:57:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:30 INFO - 'use_talos_json': True, 09:57:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:30 INFO - 'work_dir': 'build'} 09:57:30 INFO - ##### 09:57:30 INFO - ##### Running clobber step. 09:57:30 INFO - ##### 09:57:30 INFO - Running pre-action listener: _resource_record_pre_action 09:57:30 INFO - Running main action method: clobber 09:57:30 INFO - rmtree: /builds/slave/test/build 09:57:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:31 INFO - Running post-action listener: _resource_record_post_action 09:57:31 INFO - ##### 09:57:31 INFO - ##### Running read-buildbot-config step. 09:57:31 INFO - ##### 09:57:31 INFO - Running pre-action listener: _resource_record_pre_action 09:57:31 INFO - Running main action method: read_buildbot_config 09:57:31 INFO - Using buildbot properties: 09:57:31 INFO - { 09:57:31 INFO - "project": "", 09:57:31 INFO - "product": "firefox", 09:57:31 INFO - "script_repo_revision": "production", 09:57:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:57:31 INFO - "repository": "", 09:57:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:57:31 INFO - "buildid": "20160525072441", 09:57:31 INFO - "pgo_build": "True", 09:57:31 INFO - "basedir": "/builds/slave/test", 09:57:31 INFO - "buildnumber": 250, 09:57:31 INFO - "slavename": "talos-linux64-ix-011", 09:57:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:57:31 INFO - "platform": "ubuntu64_hw", 09:57:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:57:31 INFO - "branch": "mozilla-beta", 09:57:31 INFO - "repo_path": "releases/mozilla-beta", 09:57:31 INFO - "revision": "c4cf7fcd62d3cb5f1e2f5f7f0227459415017771", 09:57:31 INFO - "stage_platform": "linux64-pgo", 09:57:31 INFO - "builduid": "b83e0d635e784aa5adb2c3d241f93675", 09:57:31 INFO - "slavebuilddir": "test" 09:57:31 INFO - } 09:57:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 09:57:31 INFO - Running post-action listener: _resource_record_post_action 09:57:31 INFO - ##### 09:57:31 INFO - ##### Running download-and-extract step. 09:57:31 INFO - ##### 09:57:31 INFO - Running pre-action listener: _resource_record_pre_action 09:57:31 INFO - Running main action method: download_and_extract 09:57:31 INFO - mkdir: /builds/slave/test/build/tests 09:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:31 INFO - https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:57:35 INFO - Downloaded 1412 bytes. 09:57:35 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:57:35 INFO - Using the following test package requirements: 09:57:35 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:57:35 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:57:35 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:35 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:57:35 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 09:57:35 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:57:35 INFO - u'jsshell-linux-x86_64.zip'], 09:57:35 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:57:35 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:35 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:57:35 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:57:35 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 09:57:35 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:57:35 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 09:57:35 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:57:35 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:35 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:57:35 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:57:35 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:35 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:35 INFO - https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:39 INFO - Downloaded 23434605 bytes. 09:57:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:57:40 INFO - Return code: 0 09:57:40 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:40 INFO - https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:41 INFO - Downloaded 23434605 bytes. 09:57:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:57:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:57:43 INFO - Return code: 0 09:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:43 INFO - https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:57:43 INFO - Downloaded 10845194 bytes. 09:57:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:57:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:57:44 INFO - Return code: 0 09:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:44 INFO - https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:57:45 INFO - Downloaded 53863584 bytes. 09:57:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:57:45 INFO - mkdir: /builds/slave/test/properties 09:57:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:45 INFO - Contents: 09:57:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:57:46 INFO - Running post-action listener: _resource_record_post_action 09:57:46 INFO - Running post-action listener: set_extra_try_arguments 09:57:46 INFO - ##### 09:57:46 INFO - ##### Running populate-webroot step. 09:57:46 INFO - ##### 09:57:46 INFO - Running pre-action listener: _resource_record_pre_action 09:57:46 INFO - Running main action method: populate_webroot 09:57:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:46 INFO - '--tppagecycles', 09:57:46 INFO - '7'], 09:57:46 INFO - 'tests': ['tsvgm']}}, 09:57:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:57:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:57:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:46 INFO - 'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:46 INFO - 'tests': ['damp', 'tps']}, 09:57:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:46 INFO - 'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['damp', 'tps']}, 09:57:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:57:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:46 INFO - 'other': {'tests': ['a11yr', 09:57:46 INFO - 'ts_paint', 09:57:46 INFO - 'tpaint', 09:57:46 INFO - 'sessionrestore', 09:57:46 INFO - 'sessionrestore_no_auto_restore', 09:57:46 INFO - 'tabpaint']}, 09:57:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['a11yr', 09:57:46 INFO - 'ts_paint', 09:57:46 INFO - 'tpaint', 09:57:46 INFO - 'sessionrestore', 09:57:46 INFO - 'sessionrestore_no_auto_restore', 09:57:46 INFO - 'tabpaint']}, 09:57:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['a11yr', 09:57:46 INFO - 'ts_paint', 09:57:46 INFO - 'tpaint', 09:57:46 INFO - 'sessionrestore', 09:57:46 INFO - 'sessionrestore_no_auto_restore', 09:57:46 INFO - 'tabpaint']}, 09:57:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['a11yr', 09:57:46 INFO - 'ts_paint', 09:57:46 INFO - 'tpaint', 09:57:46 INFO - 'sessionrestore', 09:57:46 INFO - 'sessionrestore_no_auto_restore', 09:57:46 INFO - 'tabpaint']}, 09:57:46 INFO - 'other_l64': {'tests': ['a11yr', 09:57:46 INFO - 'ts_paint', 09:57:46 INFO - 'tpaint', 09:57:46 INFO - 'sessionrestore', 09:57:46 INFO - 'sessionrestore_no_auto_restore', 09:57:46 INFO - 'tabpaint']}, 09:57:46 INFO - 'other_nol64': {'tests': ['a11yr', 09:57:46 INFO - 'ts_paint', 09:57:46 INFO - 'tpaint', 09:57:46 INFO - 'sessionrestore', 09:57:46 INFO - 'sessionrestore_no_auto_restore', 09:57:46 INFO - 'tabpaint']}, 09:57:46 INFO - 'svgr': {'tests': ['tsvgx', 09:57:46 INFO - 'tsvgr_opacity', 09:57:46 INFO - 'tart', 09:57:46 INFO - 'tscrollx', 09:57:46 INFO - 'cart']}, 09:57:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['tsvgx', 09:57:46 INFO - 'tsvgr_opacity', 09:57:46 INFO - 'tart', 09:57:46 INFO - 'tscrollx', 09:57:46 INFO - 'cart']}, 09:57:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:46 INFO - 'tests': ['tp5o']}, 09:57:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:46 INFO - 'talos_options': ['--e10s'], 09:57:46 INFO - 'tests': ['tp5o']}, 09:57:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:46 INFO - 'talos_options': ['--xperf_path', 09:57:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:46 INFO - 'tests': ['tp5n']}, 09:57:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:46 INFO - 'talos_options': ['--e10s', 09:57:46 INFO - '--xperf_path', 09:57:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:46 INFO - 'tests': ['tp5n']}}, 09:57:46 INFO - 'talos.zip': {'path': '', 09:57:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:46 INFO - Running post-action listener: _resource_record_post_action 09:57:46 INFO - ##### 09:57:46 INFO - ##### Running create-virtualenv step. 09:57:46 INFO - ##### 09:57:46 INFO - Running pre-action listener: _resource_record_pre_action 09:57:46 INFO - Running main action method: create_virtualenv 09:57:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:57:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:46 INFO - Using real prefix '/usr' 09:57:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:48 INFO - Installing pip.................done. 09:57:49 INFO - Return code: 0 09:57:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:49 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:57:49 INFO - Using env: {'DISPLAY': ':0', 09:57:49 INFO - 'HOME': '/home/cltbld', 09:57:49 INFO - 'LANG': 'en_US.UTF-8', 09:57:49 INFO - 'LANGUAGE': 'en_US:en', 09:57:49 INFO - 'LOGNAME': 'cltbld', 09:57:49 INFO - 'MAIL': '/var/mail/cltbld', 09:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:49 INFO - 'MOZ_NO_REMOTE': '1', 09:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:49 INFO - 'NO_EM_RESTART': '1', 09:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:49 INFO - 'PWD': '/builds/slave/test', 09:57:49 INFO - 'SHELL': '/bin/bash', 09:57:49 INFO - 'SHLVL': '1', 09:57:49 INFO - 'TERM': 'linux', 09:57:49 INFO - 'TMOUT': '86400', 09:57:49 INFO - 'USER': 'cltbld', 09:57:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:49 INFO - '_': '/tools/buildbot/bin/python'} 09:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:57:49 INFO - Cleaning up... 09:57:49 INFO - Return code: 0 09:57:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:49 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:57:49 INFO - Using env: {'DISPLAY': ':0', 09:57:49 INFO - 'HOME': '/home/cltbld', 09:57:49 INFO - 'LANG': 'en_US.UTF-8', 09:57:49 INFO - 'LANGUAGE': 'en_US:en', 09:57:49 INFO - 'LOGNAME': 'cltbld', 09:57:49 INFO - 'MAIL': '/var/mail/cltbld', 09:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:49 INFO - 'MOZ_NO_REMOTE': '1', 09:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:49 INFO - 'NO_EM_RESTART': '1', 09:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:49 INFO - 'PWD': '/builds/slave/test', 09:57:49 INFO - 'SHELL': '/bin/bash', 09:57:49 INFO - 'SHLVL': '1', 09:57:49 INFO - 'TERM': 'linux', 09:57:49 INFO - 'TMOUT': '86400', 09:57:49 INFO - 'USER': 'cltbld', 09:57:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:49 INFO - '_': '/tools/buildbot/bin/python'} 09:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:49 INFO - Downloading/unpacking psutil>=0.7.1 09:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:51 INFO - Installing collected packages: psutil 09:57:51 INFO - Running setup.py install for psutil 09:57:51 INFO - building 'psutil._psutil_linux' extension 09:57:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:57:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:57:51 INFO - building 'psutil._psutil_posix' extension 09:57:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:57:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:51 INFO - Successfully installed psutil 09:57:51 INFO - Cleaning up... 09:57:51 INFO - Return code: 0 09:57:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:51 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:57:51 INFO - Using env: {'DISPLAY': ':0', 09:57:51 INFO - 'HOME': '/home/cltbld', 09:57:51 INFO - 'LANG': 'en_US.UTF-8', 09:57:51 INFO - 'LANGUAGE': 'en_US:en', 09:57:51 INFO - 'LOGNAME': 'cltbld', 09:57:51 INFO - 'MAIL': '/var/mail/cltbld', 09:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:51 INFO - 'MOZ_NO_REMOTE': '1', 09:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:51 INFO - 'NO_EM_RESTART': '1', 09:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:51 INFO - 'PWD': '/builds/slave/test', 09:57:51 INFO - 'SHELL': '/bin/bash', 09:57:51 INFO - 'SHLVL': '1', 09:57:51 INFO - 'TERM': 'linux', 09:57:51 INFO - 'TMOUT': '86400', 09:57:51 INFO - 'USER': 'cltbld', 09:57:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:51 INFO - '_': '/tools/buildbot/bin/python'} 09:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:54 INFO - Installing collected packages: mozsystemmonitor 09:57:54 INFO - Running setup.py install for mozsystemmonitor 09:57:54 INFO - Successfully installed mozsystemmonitor 09:57:54 INFO - Cleaning up... 09:57:54 INFO - Return code: 0 09:57:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:57:54 INFO - Using env: {'DISPLAY': ':0', 09:57:54 INFO - 'HOME': '/home/cltbld', 09:57:54 INFO - 'LANG': 'en_US.UTF-8', 09:57:54 INFO - 'LANGUAGE': 'en_US:en', 09:57:54 INFO - 'LOGNAME': 'cltbld', 09:57:54 INFO - 'MAIL': '/var/mail/cltbld', 09:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:54 INFO - 'MOZ_NO_REMOTE': '1', 09:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:54 INFO - 'NO_EM_RESTART': '1', 09:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:54 INFO - 'PWD': '/builds/slave/test', 09:57:54 INFO - 'SHELL': '/bin/bash', 09:57:54 INFO - 'SHLVL': '1', 09:57:54 INFO - 'TERM': 'linux', 09:57:54 INFO - 'TMOUT': '86400', 09:57:54 INFO - 'USER': 'cltbld', 09:57:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:54 INFO - '_': '/tools/buildbot/bin/python'} 09:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:56 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:56 INFO - Downloading docopt-0.6.1.tar.gz 09:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:57 INFO - Running setup.py install for blobuploader 09:57:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:57 INFO - Running setup.py install for requests 09:57:57 INFO - Running setup.py install for docopt 09:57:57 INFO - Successfully installed blobuploader requests docopt 09:57:57 INFO - Cleaning up... 09:57:57 INFO - Return code: 0 09:57:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:57:57 INFO - Using env: {'DISPLAY': ':0', 09:57:57 INFO - 'HOME': '/home/cltbld', 09:57:57 INFO - 'LANG': 'en_US.UTF-8', 09:57:57 INFO - 'LANGUAGE': 'en_US:en', 09:57:57 INFO - 'LOGNAME': 'cltbld', 09:57:57 INFO - 'MAIL': '/var/mail/cltbld', 09:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:57 INFO - 'MOZ_NO_REMOTE': '1', 09:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:57 INFO - 'NO_EM_RESTART': '1', 09:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:57 INFO - 'PWD': '/builds/slave/test', 09:57:57 INFO - 'SHELL': '/bin/bash', 09:57:57 INFO - 'SHLVL': '1', 09:57:57 INFO - 'TERM': 'linux', 09:57:57 INFO - 'TMOUT': '86400', 09:57:57 INFO - 'USER': 'cltbld', 09:57:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:57 INFO - '_': '/tools/buildbot/bin/python'} 09:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:57 INFO - Running setup.py (path:/tmp/pip-QRnEK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:57 INFO - Running setup.py (path:/tmp/pip-Es4Agy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:58 INFO - Running setup.py (path:/tmp/pip-vaGHKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:58 INFO - Running setup.py (path:/tmp/pip-NNKqZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:58 INFO - Running setup.py (path:/tmp/pip-iqAzyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:58 INFO - Running setup.py (path:/tmp/pip-jlTeCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:58 INFO - Running setup.py (path:/tmp/pip-smri4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:58 INFO - Running setup.py (path:/tmp/pip-VikTRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:58 INFO - Running setup.py (path:/tmp/pip-_YiZOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:58 INFO - Running setup.py (path:/tmp/pip-DayTD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:58 INFO - Running setup.py (path:/tmp/pip-oBX8cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:58 INFO - Running setup.py (path:/tmp/pip-USJi2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:58 INFO - Running setup.py (path:/tmp/pip-0sinL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:58 INFO - Running setup.py (path:/tmp/pip-PA9hvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:58 INFO - Running setup.py (path:/tmp/pip-_eZFr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:58 INFO - Running setup.py (path:/tmp/pip-iKFG9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:59 INFO - Running setup.py (path:/tmp/pip-Z7ZmNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:59 INFO - Running setup.py install for manifestparser 09:57:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozcrash 09:57:59 INFO - Running setup.py install for mozdebug 09:57:59 INFO - Running setup.py install for mozdevice 09:57:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozfile 09:57:59 INFO - Running setup.py install for mozhttpd 09:57:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozinfo 09:57:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozInstall 09:57:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:59 INFO - Running setup.py install for mozleak 09:57:59 INFO - Running setup.py install for mozlog 09:58:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Running setup.py install for moznetwork 09:58:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Running setup.py install for mozprocess 09:58:00 INFO - Running setup.py install for mozprofile 09:58:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Running setup.py install for mozrunner 09:58:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Running setup.py install for mozscreenshot 09:58:00 INFO - Running setup.py install for moztest 09:58:00 INFO - Running setup.py install for mozversion 09:58:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:00 INFO - Cleaning up... 09:58:00 INFO - Return code: 0 09:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:00 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:00 INFO - Using env: {'DISPLAY': ':0', 09:58:00 INFO - 'HOME': '/home/cltbld', 09:58:00 INFO - 'LANG': 'en_US.UTF-8', 09:58:00 INFO - 'LANGUAGE': 'en_US:en', 09:58:00 INFO - 'LOGNAME': 'cltbld', 09:58:00 INFO - 'MAIL': '/var/mail/cltbld', 09:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:00 INFO - 'MOZ_NO_REMOTE': '1', 09:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:00 INFO - 'NO_EM_RESTART': '1', 09:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:00 INFO - 'PWD': '/builds/slave/test', 09:58:00 INFO - 'SHELL': '/bin/bash', 09:58:00 INFO - 'SHLVL': '1', 09:58:00 INFO - 'TERM': 'linux', 09:58:00 INFO - 'TMOUT': '86400', 09:58:00 INFO - 'USER': 'cltbld', 09:58:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:00 INFO - '_': '/tools/buildbot/bin/python'} 09:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:01 INFO - Running setup.py (path:/tmp/pip-rCwH8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:01 INFO - Running setup.py (path:/tmp/pip-zQ0knf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:01 INFO - Running setup.py (path:/tmp/pip-1WiGbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:01 INFO - Running setup.py (path:/tmp/pip-Mzr6xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:01 INFO - Running setup.py (path:/tmp/pip-oEj_uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:01 INFO - Running setup.py (path:/tmp/pip-vuYoWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:01 INFO - Running setup.py (path:/tmp/pip-tKz9xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:01 INFO - Running setup.py (path:/tmp/pip-DR1F15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:01 INFO - Running setup.py (path:/tmp/pip-b7clMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:01 INFO - Running setup.py (path:/tmp/pip-C04_xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:01 INFO - Running setup.py (path:/tmp/pip-r1ZTyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:01 INFO - Running setup.py (path:/tmp/pip-EZupWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:01 INFO - Running setup.py (path:/tmp/pip-Fr_zS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:02 INFO - Running setup.py (path:/tmp/pip-qmV2rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:02 INFO - Running setup.py (path:/tmp/pip-Cw5b_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:02 INFO - Running setup.py (path:/tmp/pip-9HwxKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:02 INFO - Running setup.py (path:/tmp/pip-57to3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:04 INFO - Downloading blessings-1.6.tar.gz 09:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:04 INFO - Installing collected packages: blessings 09:58:04 INFO - Running setup.py install for blessings 09:58:04 INFO - Successfully installed blessings 09:58:04 INFO - Cleaning up... 09:58:04 INFO - Return code: 0 09:58:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:04 INFO - Reading from file tmpfile_stdout 09:58:04 INFO - Current package versions: 09:58:04 INFO - argparse == 1.2.1 09:58:04 INFO - blessings == 1.6 09:58:04 INFO - blobuploader == 1.2.4 09:58:04 INFO - docopt == 0.6.1 09:58:04 INFO - manifestparser == 1.1 09:58:04 INFO - mozInstall == 1.12 09:58:04 INFO - mozcrash == 0.17 09:58:04 INFO - mozdebug == 0.1 09:58:04 INFO - mozdevice == 0.48 09:58:04 INFO - mozfile == 1.2 09:58:04 INFO - mozhttpd == 0.7 09:58:04 INFO - mozinfo == 0.9 09:58:04 INFO - mozleak == 0.1 09:58:04 INFO - mozlog == 3.1 09:58:04 INFO - moznetwork == 0.27 09:58:04 INFO - mozprocess == 0.22 09:58:04 INFO - mozprofile == 0.28 09:58:04 INFO - mozrunner == 6.11 09:58:04 INFO - mozscreenshot == 0.1 09:58:04 INFO - mozsystemmonitor == 0.0 09:58:04 INFO - moztest == 0.7 09:58:04 INFO - mozversion == 1.4 09:58:04 INFO - psutil == 3.1.1 09:58:04 INFO - requests == 1.2.3 09:58:04 INFO - wsgiref == 0.1.2 09:58:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:04 INFO - Using env: {'DISPLAY': ':0', 09:58:04 INFO - 'HOME': '/home/cltbld', 09:58:04 INFO - 'LANG': 'en_US.UTF-8', 09:58:04 INFO - 'LANGUAGE': 'en_US:en', 09:58:04 INFO - 'LOGNAME': 'cltbld', 09:58:04 INFO - 'MAIL': '/var/mail/cltbld', 09:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:04 INFO - 'MOZ_NO_REMOTE': '1', 09:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:04 INFO - 'NO_EM_RESTART': '1', 09:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:04 INFO - 'PWD': '/builds/slave/test', 09:58:04 INFO - 'SHELL': '/bin/bash', 09:58:04 INFO - 'SHLVL': '1', 09:58:04 INFO - 'TERM': 'linux', 09:58:04 INFO - 'TMOUT': '86400', 09:58:04 INFO - 'USER': 'cltbld', 09:58:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:04 INFO - '_': '/tools/buildbot/bin/python'} 09:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:58:04 INFO - Cleaning up... 09:58:04 INFO - Return code: 0 09:58:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:58:04 INFO - Using env: {'DISPLAY': ':0', 09:58:04 INFO - 'HOME': '/home/cltbld', 09:58:04 INFO - 'LANG': 'en_US.UTF-8', 09:58:04 INFO - 'LANGUAGE': 'en_US:en', 09:58:04 INFO - 'LOGNAME': 'cltbld', 09:58:04 INFO - 'MAIL': '/var/mail/cltbld', 09:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:04 INFO - 'MOZ_NO_REMOTE': '1', 09:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:04 INFO - 'NO_EM_RESTART': '1', 09:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:04 INFO - 'PWD': '/builds/slave/test', 09:58:04 INFO - 'SHELL': '/bin/bash', 09:58:04 INFO - 'SHLVL': '1', 09:58:04 INFO - 'TERM': 'linux', 09:58:04 INFO - 'TMOUT': '86400', 09:58:04 INFO - 'USER': 'cltbld', 09:58:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:04 INFO - '_': '/tools/buildbot/bin/python'} 09:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:05 INFO - Downloading/unpacking jsonschema 09:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:06 INFO - Downloading/unpacking functools32 (from jsonschema) 09:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:07 INFO - warning: no files found matching '*.txt' 09:58:07 INFO - no previously-included directories found matching 'build' 09:58:07 INFO - no previously-included directories found matching 'dist' 09:58:07 INFO - no previously-included directories found matching '.git*' 09:58:07 INFO - Installing collected packages: jsonschema, functools32 09:58:07 INFO - Running setup.py install for functools32 09:58:07 INFO - warning: no files found matching '*.txt' 09:58:07 INFO - no previously-included directories found matching 'build' 09:58:07 INFO - no previously-included directories found matching 'dist' 09:58:07 INFO - no previously-included directories found matching '.git*' 09:58:07 INFO - Successfully installed jsonschema functools32 09:58:07 INFO - Cleaning up... 09:58:07 INFO - Return code: 0 09:58:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:07 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 0x7f6ed8c25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ec410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:58:07 INFO - Using env: {'DISPLAY': ':0', 09:58:07 INFO - 'HOME': '/home/cltbld', 09:58:07 INFO - 'LANG': 'en_US.UTF-8', 09:58:07 INFO - 'LANGUAGE': 'en_US:en', 09:58:07 INFO - 'LOGNAME': 'cltbld', 09:58:07 INFO - 'MAIL': '/var/mail/cltbld', 09:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:07 INFO - 'MOZ_NO_REMOTE': '1', 09:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:07 INFO - 'NO_EM_RESTART': '1', 09:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:07 INFO - 'PWD': '/builds/slave/test', 09:58:07 INFO - 'SHELL': '/bin/bash', 09:58:07 INFO - 'SHLVL': '1', 09:58:07 INFO - 'TERM': 'linux', 09:58:07 INFO - 'TMOUT': '86400', 09:58:07 INFO - 'USER': 'cltbld', 09:58:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:07 INFO - '_': '/tools/buildbot/bin/python'} 09:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:07 INFO - Downloading/unpacking flake8 09:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:58:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:58:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:10 INFO - no previously-included directories found matching 'docs/_build' 09:58:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:58:10 INFO - Running setup.py install for pep8 09:58:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:10 INFO - no previously-included directories found matching 'docs/_build' 09:58:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:58:10 INFO - Cleaning up... 09:58:10 INFO - Return code: 0 09:58:10 INFO - Running post-action listener: _resource_record_post_action 09:58:10 INFO - Running post-action listener: _start_resource_monitoring 09:58:10 INFO - Starting resource monitoring. 09:58:10 INFO - ##### 09:58:10 INFO - ##### Running install step. 09:58:10 INFO - ##### 09:58:10 INFO - Running pre-action listener: _resource_record_pre_action 09:58:10 INFO - Running main action method: install 09:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:10 INFO - Reading from file tmpfile_stdout 09:58:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:10 INFO - Reading from file tmpfile_stdout 09:58:10 INFO - Output received: 09:58:10 INFO - Usage: mozinstall [options] installer 09:58:10 INFO - Options: 09:58:10 INFO - -h, --help show this help message and exit 09:58:10 INFO - -d DEST, --destination=DEST 09:58:10 INFO - Directory to install application into. [default: 09:58:10 INFO - "/builds/slave/test"] 09:58:10 INFO - --app=APP Application being installed. [default: firefox] 09:58:10 INFO - mkdir: /builds/slave/test/build/application 09:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:58:23 INFO - Reading from file tmpfile_stdout 09:58:23 INFO - Output received: 09:58:23 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:23 INFO - Running post-action listener: _resource_record_post_action 09:58:23 INFO - ##### 09:58:23 INFO - ##### Running run-tests step. 09:58:23 INFO - ##### 09:58:23 INFO - Running pre-action listener: _resource_record_pre_action 09:58:23 INFO - Running main action method: run_tests 09:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:23 INFO - Python 2.7.3 09:58:23 INFO - Return code: 0 09:58:23 INFO - grabbing minidump binary from tooltool 09:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:23 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 0x217b160>, '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 0x217c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217c4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:58:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:58:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:23 INFO - Return code: 0 09:58:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:58:24 INFO - Return code: 0 09:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:58:24 INFO - Using env: {'DISPLAY': ':0', 09:58:24 INFO - 'HOME': '/home/cltbld', 09:58:24 INFO - 'LANG': 'en_US.UTF-8', 09:58:24 INFO - 'LANGUAGE': 'en_US:en', 09:58:24 INFO - 'LOGNAME': 'cltbld', 09:58:24 INFO - 'MAIL': '/var/mail/cltbld', 09:58:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:24 INFO - 'MOZ_NO_REMOTE': '1', 09:58:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:24 INFO - 'NO_EM_RESTART': '1', 09:58:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:24 INFO - 'PWD': '/builds/slave/test', 09:58:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:24 INFO - 'SHELL': '/bin/bash', 09:58:24 INFO - 'SHLVL': '1', 09:58:24 INFO - 'TERM': 'linux', 09:58:24 INFO - 'TMOUT': '86400', 09:58:24 INFO - 'USER': 'cltbld', 09:58:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621', 09:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:24 INFO - '_': '/tools/buildbot/bin/python'} 09:58:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:58:24 INFO - mozversion application_buildid: 20160525072441 09:58:24 INFO - mozversion application_changeset: c4cf7fcd62d3cb5f1e2f5f7f0227459415017771 09:58:24 INFO - mozversion application_display_name: Firefox 09:58:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:24 INFO - mozversion application_name: Firefox 09:58:24 INFO - mozversion application_remotingname: firefox 09:58:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:58:24 INFO - mozversion application_vendor: Mozilla 09:58:24 INFO - mozversion application_version: 47.0 09:58:24 INFO - mozversion platform_buildid: 20160525072441 09:58:24 INFO - mozversion platform_changeset: c4cf7fcd62d3cb5f1e2f5f7f0227459415017771 09:58:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:58:24 INFO - mozversion platform_version: 47.0 09:58:24 INFO - using testdate: 1464195504 09:58:24 INFO - actual date: 1464195504 09:58:24 INFO - starting webserver on 'localhost:60221' 09:58:24 INFO - SUITE-START | Running 2 tests 09:58:24 INFO - TEST-START | dromaeo_css 09:58:24 INFO - operating with platform_type : linux_ 09:58:24 INFO - Initialising browser for dromaeo_css test... 09:58:24 INFO - TEST-INFO | started process 17007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCJq6A5/profile http://localhost:60221/getInfo.html) 09:58:30 INFO - PROCESS | 17007 | __metrics Screen width/height:1600/1200 09:58:30 INFO - PROCESS | 17007 | colorDepth:24 09:58:30 INFO - PROCESS | 17007 | Browser inner width/height: 1024/697 09:58:30 INFO - PROCESS | 17007 | __metrics 09:58:31 INFO - PROCESS | 17007 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:33 INFO - TEST-INFO | 17007: exit 0 09:58:33 INFO - Browser initialized. 09:58:33 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:33 INFO - TEST-INFO | started process 17097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCJq6A5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:45 INFO - PROCESS | 17097 | RSS: Main: 138747904 09:58:45 INFO - PROCESS | 17097 | 09:59:36 INFO - PROCESS | 17097 | 1464195576046 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:01:44 INFO - PROCESS | 17097 | Cycle 1(1): loaded http://localhost:60221/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60221/tests/dromaeo/cssquery-ext.html) 10:01:45 INFO - PROCESS | 17097 | RSS: Main: 255475712 10:01:45 INFO - PROCESS | 17097 | 10:04:47 INFO - PROCESS | 17097 | Cycle 1(1): loaded http://localhost:60221/tests/dromaeo/cssquery-ext.html (next: http://localhost:60221/tests/dromaeo/cssquery-jquery.html) 10:04:48 INFO - PROCESS | 17097 | RSS: Main: 225165312 10:04:48 INFO - PROCESS | 17097 | 10:07:50 INFO - PROCESS | 17097 | Cycle 1(1): loaded http://localhost:60221/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60221/tests/dromaeo/cssquery-mootools.html) 10:07:50 INFO - PROCESS | 17097 | RSS: Main: 235868160 10:07:50 INFO - PROCESS | 17097 | 10:10:52 INFO - PROCESS | 17097 | Cycle 1(1): loaded http://localhost:60221/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60221/tests/dromaeo/cssquery-prototype.html) 10:10:52 INFO - PROCESS | 17097 | RSS: Main: 197943296 10:10:52 INFO - PROCESS | 17097 | 10:13:55 INFO - PROCESS | 17097 | Cycle 1(1): loaded http://localhost:60221/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60221/tests/dromaeo/cssquery-yui.html) 10:13:55 INFO - PROCESS | 17097 | RSS: Main: 212398080 10:13:55 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | Cycle 1(1): loaded http://localhost:60221/tests/dromaeo/cssquery-yui.html (next: http://localhost:60221/tests/dromaeo/cssquery-dojo.html) 10:16:58 INFO - PROCESS | 17097 | RSS: Main: 256524288 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | __start_tp_report 10:16:58 INFO - PROCESS | 17097 | _x_x_mozilla_page_load 10:16:58 INFO - PROCESS | 17097 | _x_x_mozilla_page_load_details 10:16:58 INFO - PROCESS | 17097 | |i|pagename|runs| 10:16:58 INFO - PROCESS | 17097 | |0;dojo.html;3296.1100502864224;3334.81658508782;3344.665533446654;3370.831458427078;3382.424987752082;5434.212039254306;5447.373552041517;5450.236966824647;5469;5478.616496845222;5459.372172200198;5477.5070243678065;5484.698341591211;5485.067538518451;5511.724413779305;4817.373741413611;4983;5004.699718016913;5073.061483625541;5103.157978933472;4951.579115775164;5045.520675535819;5052;5053.444121146671;5055.77249023793;5013.097642424362;5046.772895219706;5078.8730281743065;5082.364704411949;5082.644214904958;5044.772985215655;5089.949100509021;5101.20931255656;5103.693778373309;5123.564497017758;4910.091633047898;4945;5013.799448022075;5014.147594908874;5049.065922804293;5317.548008419289;5343.706096164709;5349.919751203735;5358.785648574052;5365.812196573141;5769.1923130761725;5881.823545293648;5920.881582368372;5927.1405646181065;5957.434043765836;5872.911906321408;5911.55663325248;5945.64326140433;5950.107483877453;5961.791337303173;5461.563074953994;5519.641223320471;5520.503154716095;5522.0336441122645;5523;5893.057110862242;5999.610025348338;6014.308354539196;6029.668368239789;6081.422264884829;5692.31692196939;5703.572232082611;5704.34400043992;5704.401037890962;5711.828645140652;5788.27646544182;5798.739056742456;5803.332616749043;5804.04233301509;5811.186433899257;5672.517835983987;5739.684317362585;5832.270966129234;5925.318588362307;5933.110033495011;5779.595428319977;5782.59521833476;5783.074708046693;5786.247787787561;5788.971055144697;4444.9998750281575;4450.821967121344;4452.0205554777895;4457.68796184264;4477.3731677565165;3962.465067215889;4005.5794141615293;4049.7367671101283;4056.472658554428;4088.12105397341;5569.582281328917;5582.078956972054;5594.776208951596;5597.188407680864;5636.887262254732;5749.741261643236;5776.537876969833;5873.3832947539895;5883.264591926009;5887.293524777054;5626.690532020696;5649.858753531194;5664.178694089416;5673.432656734293;5709;5099.413567439792;5105;5132.717700526432;5133.050385678662;5169.302144210558;5867.090600956859;5993.760249590055;6154.876902462015;6156.168917196211;6158.3841615838055;5926.555508336805;5944.613600115978;5949.3753155918;5955.017422125301;5979.4917432018765;6065.6663883486835;6068.969655151873;6084.695765211633;6086.843499735036;6122.846928826815;5713.971430142823;5786.623869448473;5844.561657875592;5847.707614619167;5856.297244330537;5915.615484993462;5944.108383742473;5946.345901950695;5951.315598706031;5967.791127310524;5739.139129130664;5793.478586927196;5794.246747922743;5798.449147330997;5800.796972105956;5560.694161821139;5708.514776244066;5759.078547432391;5768.769249229984;5807.506361959281;5647.661140331593;5654.46282603152;5655.208270842003;5665.291838520185;5669.6314739541795;5775.306963164279;5792.304923409218;5793.652380857162;5793.884122317446;5797.739101740347;5490.231367608458;5530.668159910419;5612.326520817528;5630.493255606852;5692.886142277214 10:16:58 INFO - PROCESS | 17097 | |1;ext.html;543.3181357396468;547.7179252684865;561.7275621323658;569.1320735877788;575.6114622629724;40492.59507404925;41608;41633.58366416339;41710;41720;45442.31836522446;46205.30692039622;46256.53743462573;46304.76847615757;46330.53669463305;8835.851339325895;9020.188183063523;9030.729078127666;9041.819163616723;9042.231410330098;8810.207081362676;8950.14973577509;8950.149735775123;9186.311026672993;9197.356185067049;9189.908100919005;9227.3079519036;9267.768305792342;9276.072392760738;9281.257499400032;9088.182063614273;9158.129977652112;9173.862392064124;9194.862077068849;9195.126462986005;9090.318226133;9210.585523651453;9242.907570924339;9245.953770231106;9246.214071803905;44542.777286113684;45033.09933801338;45067.323990140176;45250.321245181345;45275.32087018697;3802.0874990002476;3851.614838516154;3913.9804300978312;3955.5451123120633;4262.403263543107;32783.50824737631;33333.6666633333;33573.32853342944;34342.65657343445;34869.30261394783;3950.2889479893606;3985.6811455083525;3989.5238761658084;4033.3143365627916;4051.0885050863612;235091;235724;235993;236850;237654;63898.68050659717;65226.34773652298;65227.67386163134;65387;65406;74779;75249;75580.62209689026;75640;75689;16201.4329498467;16452.341906323614;16585.087820169767;16621;16621.584460388585;13366;13412.530561430303;13444.193348399127;13446.058775885595;13467.461301548024;21948.34154975353;22154.113835446726;22206;22215;23288.06847726072;7825.256600622932;7991.600419978978;8092.514449132953;8123.222701443857;8193.286720246786;952.7760976170595;1018.5467466977273;1103.5751235774123;1144.2733863996257;1144.9942750286195;30984.0704778857;31025.8448707755;31112;31523.527147092813;31629;1091.939943303126;1145.4673576786834;1174.4362705901215;1189.1259923955886;1205.8854408831146;14480;14609.78085328721;14663.28982401458;14709.632259193391;15037.172955487553;335335;335609;336589;337624;337973;60086.09870851941;60777.39222607806;60818.391816082156;60842.69578652078;60867.39132608706;1239.1202246405153;1365.481117175467;1373.4986729843736;1425.2944792327864;1476.0922032949659;27990;28153.859230703714;28431.43137137287;28978.985735499155;28993.565096523147;43854.34218486661;44318.77840610905;44595.10809783851;44627;44649.33026004677;221397;222787;223491;223516;223595;30705.385892282477;35121;35709;35885.461718073726;36731.81634091812;42017.78991105025;43105.56894431016;43400.34899476447;43783.78108109439;43914.78042609766;36042.8197859009;36608.81695591505;37969.810150949066;38892.2221555573;38955.805220973714;37464;38110.428343575426;38435.6156438432;38735;38978.6102138975;37760;38775.2244955105;38844;39178.80410597929;39332.2133557333;34115.31769364549;35060.64939350574;35181.29637407186;35519;35628;26506.337341566614;26570.86714566492;26729.33176670599;26790.330241744112;26865.865670671523 10:16:58 INFO - PROCESS | 17097 | |2;jquery.html;380.68022860796924;384.44447772968056;384.450236162288;390.07357525876046;398.8384704194802;17639.382621608245;18314.26742930283;18778.530536736587;18874.52813679655;18897.71653425198;17566.560835979075;17913.373031943884;17914.82085179148;17958.91020544899;18248.452546423596;5511.338639363282;5751;5779.046457334534;5793.507551858097;5795.449432303945;4243.957560424387;5929.940700593003;6143.969280153616;6174.722137503801;6185.072239164117;5970.223870896777;6108.205933228674;6124.938750612481;6147.323794382637;6156.692165391735;6250;6256.1866957295715;6272.529560282974;6276.529260305495;6281.560290779625;3846.288436639231;5208.401033881077;5404.972975135099;5417.241586177938;5427.891442171174;21602;21638.783612163836;22120.88939555292;23143.0742770289;23158.76841231583;2445.461998360358;2552.680914885639;2556.2586849813533;2770.4182121754457;3160.8893688721014;14077.296135193199;14537.709245815131;14573.6356591085;14779.778303325458;15267;1847.9538011549685;1985.8907760073191;2070.7204527388762;2116.3968269043403;2145.7639659637425;65255;74986.62506687432;81460.59269703673;84277;84850.57574712149;14933.925330373278;14978.325975330918;15429.22853857325;15444.613884652974;15570.9221453892;27976.86011569929;28334.71665283321;28455.71544284572;28486;28576.285592860346;8926.241269492166;9142.497162655985;9172.082791720775;9281.350305478552;9307.395019323721;7873;7892;7922.049354077548;8047.959760201162;8195.877061844078;7845;7953.840923181504;7980.600969951479;8014.799630009296;8093.635786389626;2590.1794852592275;2899.869505872241;3012.9698703013128;3019.9547006794915;3224.613046434396;991.6281394477071;1011.4740335025746;1086.9293495922739;1105.922585419029;1115.3642423818346;17184.570385740208;17230.65538689219;17408.47774566765;17626.91186544059;18025;970.2092794372563;1003.0972125087334;1035.7514196592763;1045.926785125034;1109.4230999880178;9004.144606262395;9965.651202207888;10006.09945104944;10085.596576136872;10289.897101029044;436869;437713;439256;447904;448243;80912.19087809164;83012;83092.58453707813;83253;84210;1015.6242190389603;1020.5152552537485;1025.0876719719456;1028.4240825137947;1036.383351905615;15755.529326221587;15826.68346633084;15873.603159921095;15894.443694470638;15909.840901590836;31622.367552649277;34427;35548.82225588855;36778.8161059193;37065.258694826494;47195;50838;51090.489095108576;51164.23253651124;51360.74319628378;8421.663133474593;8444.873326900224;8446.45098068648;8572.3999320047;8756.299496040428;8777.736667899973;9909.355891867006;12842.67893302675;13120.212787232796;13225.537106201236;5397.055515284888;6064.575479716377;10404.895951040393;11366.772664546828;11585.884141158818;10813.891861081289;11246.493907774005;11660.30038197711;11861;11942.16404851652;10457.738556536147;10502.107320877505;10526.210534209811;10600.840987385349;10736.30214036085;8388.203120703523;8725.738227853175;8738.34462415334;8930.285577153682;8978.281737460857;9259;10499.632512862014;10557.419341936267;10586.10018148466;10845.511951962022 10:16:58 INFO - PROCESS | 17097 | |3;mootools.html;1377.30446124707;1560.843915608439;1593.705164544559;1828.1681834765184;1924.3745782620642;7715.498492597977;8421.157884211583;8603.053664096944;8608.61261243244;8620.137986201376;8336.791580210498;8525.488470691764;8531;8531.78670533237;8539.06070332263;2421.842580232288;2434.379233295507;2436.3300092474533;2449.5590793657134;2449.595816690253;2341.519988402373;2413.5655581995234;2450.179189971353;2451.950960980779;2457.1154384421593;2441.328634625483;2451.9754802452017;2461.4215659320043;2477.2939712182033;2479.0207867892173;2414.2395145529276;2414.9154779582805;2437.122635851092;2446.522928029026;2449.2407353720314;2408;2427.8786060696893;2436.902523899042;2440.3533063738123;2443.1937460638123;8876.8668469973;8919.063498332647;8921.776955576097;8924.419912705653;8928.553572321423;5282.630215884889;5381.139017757179;5415.729213539346;5422.267993820823;5429.53848922842;3268.5750852389274;3272.4109660261383;3327.168207948013;3345.4647256438852;3380.678835510623;1009.3741880034353;1022.0545994954638;1041.2919214933843;1054.984175237372;1085.2457542008308;12398;12413.565525206574;12472.314022728746;12500.49998000079;12503.374831258492;4601.677882548256;4668.603168730628;4742.099001189763;4756.381670382828;4756.904861902743;9647.565859536338;9677.758056048655;9713.22294216461;9733.075357840993;9742;5216.1393370094265;5219.5041471060185;5225.294585231021;5276.894462110737;5292.391374991848;4216.578342165821;4819.746865814844;4879.341288926021;4889.462159162489;4924.089043526959;3630.49173115764;3687;3692.8707495237536;3722.1439069013736;3764.265968136187;1091.411995546478;1097.40191595579;1103.089950790585;1128.8927551882557;1132.1791701016862;1221.4808706299964;1244.3467179730715;1250.956216532417;1488.0253434000747;1491.686745783376;8196.959015204886;8373.539455330016;8377.748667539983;8402.285805706584;8434.704785332484;524.8504176309809;531.6172355903743;532.8108521474899;535.162470733309;537.5914305128131;5861.17943487912;5890.823275301748;5902.8819423611285;5946.226990491208;5951.761929522857;10012.44931528773;10264.281500294908;10279.640212592672;10352.016558426938;10453.425061621532;9974.45140517264;10168.084872361374;10169.898301016896;10190.796184076276;10195.388276703421;8284.585770711441;8464.788380290418;8523.786905327417;8531.146885311418;8536.487810731376;8253.133420990709;8271.255586997198;8362.372822038493;8387.664493420194;8459.027211870714;9390.906090939003;9575.521223938636;9579.9042009579;9741.123298903132;9786.559604817943;9087.18256348746;9610.711678649652;9633.229341652792;9790.951045244728;10058.8491172631;7214.170370407471;7818.960905195438;8062.355011599176;8079.434439589408;8215.753527394188;8124.065732440845;8175;8178.713745018896;8212.3430125591;8231.506109633441;7126;7313.158986716596;7428.628568571442;7450.590217538087;7589.924100758922;7372.557646541225;7379.520331178671;7386.926130738839;7464;7529.096508419025;7843;7847.882281765892;7902.604869756604;7903.486273392211;7912.960435198018;7119.323664251888;7188.676509556978;7192.388646965067;7337.816554585965;7345.412367010519;7038.085048943604;7092.716291348288;7129.928700713134;7157.534760240567;7206.747763828241 10:16:58 INFO - PROCESS | 17097 | |4;prototype.html;356.77701436602126;360.53851070629605;362.711644242827;363.25895173845356;373.11757693055915;6007.8498037549025;6020.75916963322;6056.9999999999945;6059.333473317937;6071.817845464632;5961.046232602785;5966.642001479903;5973.4623883850445;5978.252718410199;6003.939960600393;4455.799489023002;4578.153041687298;4679.953200468003;4681.414823147098;4700.294955756647;4680.5787479126875;4690.90618187636;4699.271612899989;4703.952960470403;4711.575958163765;4640.09518143962;4655.20861453552;4663.696859704109;4665;4673.8831529211875;4436.66724995625;4514.164879497303;4637.466691330473;4655.2784318430695;4672.929906051412;4118;4128.380742888561;4132.586741325874;4134.834606615732;4139.110091330378;5675.375708672084;5690.374058853523;5690.48785609293;5698.772049118072;5704.429557044304;5422.6475279106735;5442.265294185274;5459;5461.5357694596005;5463.453654634504;6325.114483972247;6336.081268216083;6350.809475715736;6354;6356;4295.269804133305;4470.932936005963;4490.259107247301;4505.7296562206375;4610.239310513761;6575.769848055343;6636.900446493307;6639.86720265592;6642.501812364092;6649.235337936151;4608.423947006624;4616.030633566921;4617.861464156081;4620.838270660578;4623.791929363187;4686.156491831435;4686.367340409001;4687.226607609774;4689.7655117244;4690.366800481959;5376.1935709643085;5386.434424385461;5387.46125387466;5389.299391079135;5391.487808658171;6266.874662506815;6404.103425520431;6414.775482858077;6423.518236132309;6426.228852537632;1622.1321592947716;1634.87738419619;1637.5987882968511;1637.8034635843537;1642.1707037945762;1021.3361315145066;1077.6012875236213;1100.312304809494;1144.8740638529755;1169.5438778876246;6095.451409373089;6102.908456373158;6109.083637454418;6114.2357205349335;6120.846978825565;6467.450266727381;6516.837079073061;6557.540972131905;6558.934410655832;6563.50773691975;6184.845378865474;6187.783427580013;6191.566590338633;6192.59748116371;6197.442230199304;3510.8069056201643;3541.94687079694;3552.5381700378784;3555.6622120898473;3557.377458944726;6669.066330713704;6672.498687795207;6796.76211332601;6800.625965571842;6815.352541508549;6673.532852700265;6678.699458524378;6693.230278517935;6699;6701.765438209639;6747;6768.492363072789;6790;6791.830204245032;6794.524383293122;6533.379328963741;6533.901991470037;6544.214694236532;6544.8363790905605;6557.311482294481;6292.905606415816;6405.615663060045;6422;6544.574602650812;6586.110875031809;6899;6917.584944903322;6929.411000064849;6933.5493192942295;6955.156883425795;4581.404417425713;4620.653450991122;4631.235846085493;4639.118567472169;4639.4896561377545;6656.36764507371;6661.900071498834;6665.700043498151;6678.465722742266;6679.198496180489;6333.936660633519;6449.322821103904;6459.6447195402825;6462.547621666438;6481.870362592627;6443.09796628463;6460.224773027267;6467.417932386108;6471.385218404244;6481.546291759721;6317.084022816758;6327.746890124527;6336.271328797063;6341.175647165839;6347.5556711029785;6475.3200913903365;6489.091527186292;6490.058941453369;6497.740090396331;6505.869882602226;6075.908861367171;6165.630062196283;6259.530535209787;6322.747090116344;6342.2389313280855 10:16:58 INFO - PROCESS | 17097 | |5;yui.html;827.7433995461406;892.6563273139841;903.6746771162381;906.6101576322179;914.6661468563976;14531.12813231207;14817.77773333401;14870.628234294149;14935;14959.92520037401;12172.81740773889;13786.241756703377;13935.721285574307;13939.512117075905;13948.511802086929;914.3051281026418;938.6902322233647;941.3034354577632;941.3598752848061;941.9434833909953;909.3498148823589;909.440693973205;913.1416468519603;916.6699988004314;917.5320586500899;796.8286818334057;951.9666811661593;959.1846930109386;959.357230655459;961.1733908838428;797.2227078598349;799.1449149410133;942.8302905476977;961.9086186812242;962.8651988721584;713.5183750968076;714.085969958454;714.5177005521252;715.1346870286959;715.2239819795528;14630.487932922297;14658.486952956702;14666.63333416673;14666.779998300033;14669;12899.419526121346;13419.66450838727;14449.942297310006;14507.347169377403;14756.188409637465;10917.454127293604;10918.890811091867;10938.781224375547;11036.282641628268;11102.222844400896;3934.3901695236996;3945.684345252373;3973.721839471238;3975.6819454443576;4017.995501124719;51007.28761106097;51115.74442127765;51834.48165518334;52162;52873;11351.318920864775;11381.089512838953;11512.424378781028;11643.301401915744;11750.23623464472;20405.897970510054;20412.48968775763;20434.080466379048;20453.2841350552;20459.693104603444;7734.883976740353;7956.522608643384;8044.839103217902;8057.153998830156;8554.486730796172;4486.910261794746;4597.379353787196;4651.720896746138;4675.29870519418;4827.589654879374;3330.1008727643402;3345.832708364572;3360.5295258663805;3375;3393.609734880471;549.8762778374834;597.979070732531;620.5563022438978;621.5276389943675;633.2559242889587;586.9471747542742;642.2004604267623;677.1704661789367;686.8111269400855;734.4931996922106;7623.16145224036;7641.923580764233;7654.617269136521;7706.576138312446;7755;692.7644600835639;692.9480288978347;698.5354739098443;700.4606453031138;705.1502938958542;3736.4021756518828;3872.9031774205305;3893.4354518594646;4023.3964905264443;4028;57117.42882571204;57885;57940;58697.70651146717;59373.703131484064;51246;51647;51660.48339516557;52232.216516752276;52495;44341;45887;46015.76992115085;46196.07607847824;46690;7670.7698769037015;7755.146933837386;7884.250996155356;7903.644336005009;8112.391570632109;34918.65081349154;35219.47170792492;36049.27901441904;36410.45384319184;37070.44394334033;43041.78479107584;43392.13215735731;43730.562694372646;43809;43846;10333.070023697903;10587.364758114538;10658.200634952254;10960.232783705063;10996.175286853679;10755.569777209137;10928.617498387519;11224.214304998899;11579.594714184963;12072.094592905743;10340.37957722539;11073.50169242402;11176.72058198519;11398.829017564909;11553.768924621629;10382.3251488653;10383;10404;10594.629187978384;10682.412467314372;11160.162987775788;11180.10559155282;11211.55153793839;11241.381724005258;12380.81428778587;9416.199623032118;9452.480113593818;9590.232781377334;9832.55753491109;9909.752256193653;9353.158215760614;9410.29422793307;9420.057994200524;9436.480993545421;9529.809403811747 10:16:58 INFO - PROCESS | 17097 | __end_tp_report 10:16:58 INFO - PROCESS | 17097 | __start_cc_report 10:16:58 INFO - PROCESS | 17097 | _x_x_mozilla_cycle_collect,897 10:16:58 INFO - PROCESS | 17097 | __end_cc_report 10:16:58 INFO - PROCESS | 17097 | __startTimestamp1464196618373__endTimestamp 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | ------- Summary: start ------- 10:16:58 INFO - PROCESS | 17097 | Number of tests: 6 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | [#0] dojo.html Cycles:165 Average:5465.39 Median:5669.63 stddev:595.77 (10.5%) stddev-sans-first:572.78 10:16:58 INFO - PROCESS | 17097 | Values: 3296.1 3334.8 3344.7 3370.8 3382.4 5434.2 5447.4 5450.2 5469.0 5478.6 5459.4 5477.5 5484.7 5485.1 5511.7 4817.4 4983.0 5004.7 5073.1 5103.2 4951.6 5045.5 5052.0 5053.4 5055.8 5013.1 5046.8 5078.9 5082.4 5082.6 5044.8 5089.9 5101.2 5103.7 5123.6 4910.1 4945.0 5013.8 5014.1 5049.1 5317.5 5343.7 5349.9 5358.8 5365.8 5769.2 5881.8 5920.9 5927.1 5957.4 5872.9 5911.6 5945.6 5950.1 5961.8 5461.6 5519.6 5520.5 5522.0 5523.0 5893.1 5999.6 6014.3 6029.7 6081.4 5692.3 5703.6 5704.3 5704.4 5711.8 5788.3 5798.7 5803.3 5804.0 5811.2 5672.5 5739.7 5832.3 5925.3 5933.1 5779.6 5782.6 5783.1 5786.2 5789.0 4445.0 4450.8 4452.0 4457.7 4477.4 3962.5 4005.6 4049.7 4056.5 4088.1 5569.6 5582.1 5594.8 5597.2 5636.9 5749.7 5776.5 5873.4 5883.3 5887.3 5626.7 5649.9 5664.2 5673.4 5709.0 5099.4 5105.0 5132.7 5133.1 5169.3 5867.1 5993.8 6154.9 6156.2 6158.4 5926.6 5944.6 5949.4 5955.0 5979.5 6065.7 6069.0 6084.7 6086.8 6122.8 5714.0 5786.6 5844.6 5847.7 5856.3 5915.6 5944.1 5946.3 5951.3 5967.8 5739.1 5793.5 5794.2 5798.4 5800.8 5560.7 5708.5 5759.1 5768.8 5807.5 5647.7 5654.5 5655.2 5665.3 5669.6 5775.3 5792.3 5793.7 5793.9 5797.7 5490.2 5530.7 5612.3 5630.5 5692.9 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | [#1] ext.html Cycles:180 Average:45970.68 Median:38868.11 stddev:70563.66 (181.5%) stddev-sans-first:70679.17 10:16:58 INFO - PROCESS | 17097 | Values: 543.3 547.7 561.7 569.1 575.6 40492.6 41608.0 41633.6 41710.0 41720.0 45442.3 46205.3 46256.5 46304.8 46330.5 8835.9 9020.2 9030.7 9041.8 9042.2 8810.2 8950.1 8950.1 9186.3 9197.4 9189.9 9227.3 9267.8 9276.1 9281.3 9088.2 9158.1 9173.9 9194.9 9195.1 9090.3 9210.6 9242.9 9246.0 9246.2 44542.8 45033.1 45067.3 45250.3 45275.3 3802.1 3851.6 3914.0 3955.5 4262.4 32783.5 33333.7 33573.3 34342.7 34869.3 3950.3 3985.7 3989.5 4033.3 4051.1 235091.0 235724.0 235993.0 236850.0 237654.0 63898.7 65226.3 65227.7 65387.0 65406.0 74779.0 75249.0 75580.6 75640.0 75689.0 16201.4 16452.3 16585.1 16621.0 16621.6 13366.0 13412.5 13444.2 13446.1 13467.5 21948.3 22154.1 22206.0 22215.0 23288.1 7825.3 7991.6 8092.5 8123.2 8193.3 952.8 1018.5 1103.6 1144.3 1145.0 30984.1 31025.8 31112.0 31523.5 31629.0 1091.9 1145.5 1174.4 1189.1 1205.9 14480.0 14609.8 14663.3 14709.6 15037.2 335335.0 335609.0 336589.0 337624.0 337973.0 60086.1 60777.4 60818.4 60842.7 60867.4 1239.1 1365.5 1373.5 1425.3 1476.1 27990.0 28153.9 28431.4 28979.0 28993.6 43854.3 44318.8 44595.1 44627.0 44649.3 221397.0 222787.0 223491.0 223516.0 223595.0 30705.4 35121.0 35709.0 35885.5 36731.8 42017.8 43105.6 43400.3 43783.8 43914.8 36042.8 36608.8 37969.8 38892.2 38955.8 37464.0 38110.4 38435.6 38735.0 38978.6 37760.0 38775.2 38844.0 39178.8 39332.2 34115.3 35060.6 35181.3 35519.0 35628.0 26506.3 26570.9 26729.3 26790.3 26865.9 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | [#2] jquery.html Cycles:180 Average:27338.34 Median:17423.49 stddev:72752.85 (417.6%) stddev-sans-first:72928.78 10:16:58 INFO - PROCESS | 17097 | Values: 380.7 384.4 384.5 390.1 398.8 17639.4 18314.3 18778.5 18874.5 18897.7 17566.6 17913.4 17914.8 17958.9 18248.5 5511.3 5751.0 5779.0 5793.5 5795.4 4244.0 5929.9 6144.0 6174.7 6185.1 5970.2 6108.2 6124.9 6147.3 6156.7 6250.0 6256.2 6272.5 6276.5 6281.6 3846.3 5208.4 5405.0 5417.2 5427.9 21602.0 21638.8 22120.9 23143.1 23158.8 2445.5 2552.7 2556.3 2770.4 3160.9 14077.3 14537.7 14573.6 14779.8 15267.0 1848.0 1985.9 2070.7 2116.4 2145.8 65255.0 74986.6 81460.6 84277.0 84850.6 14933.9 14978.3 15429.2 15444.6 15570.9 27976.9 28334.7 28455.7 28486.0 28576.3 8926.2 9142.5 9172.1 9281.4 9307.4 7873.0 7892.0 7922.0 8048.0 8195.9 7845.0 7953.8 7980.6 8014.8 8093.6 2590.2 2899.9 3013.0 3020.0 3224.6 991.6 1011.5 1086.9 1105.9 1115.4 17184.6 17230.7 17408.5 17626.9 18025.0 970.2 1003.1 1035.8 1045.9 1109.4 9004.1 9965.7 10006.1 10085.6 10289.9 436869.0 437713.0 439256.0 447904.0 448243.0 80912.2 83012.0 83092.6 83253.0 84210.0 1015.6 1020.5 1025.1 1028.4 1036.4 15755.5 15826.7 15873.6 15894.4 15909.8 31622.4 34427.0 35548.8 36778.8 37065.3 47195.0 50838.0 51090.5 51164.2 51360.7 8421.7 8444.9 8446.5 8572.4 8756.3 8777.7 9909.4 12842.7 13120.2 13225.5 5397.1 6064.6 10404.9 11366.8 11585.9 10813.9 11246.5 11660.3 11861.0 11942.2 10457.7 10502.1 10526.2 10600.8 10736.3 8388.2 8725.7 8738.3 8930.3 8978.3 9259.0 10499.6 10557.4 10586.1 10845.5 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | [#3] mootools.html Cycles:180 Average:6021.97 Median:2959.37 stddev:3227.67 (109.1%) stddev-sans-first:3217.84 10:16:58 INFO - PROCESS | 17097 | Values: 1377.3 1560.8 1593.7 1828.2 1924.4 7715.5 8421.2 8603.1 8608.6 8620.1 8336.8 8525.5 8531.0 8531.8 8539.1 2421.8 2434.4 2436.3 2449.6 2449.6 2341.5 2413.6 2450.2 2452.0 2457.1 2441.3 2452.0 2461.4 2477.3 2479.0 2414.2 2414.9 2437.1 2446.5 2449.2 2408.0 2427.9 2436.9 2440.4 2443.2 8876.9 8919.1 8921.8 8924.4 8928.6 5282.6 5381.1 5415.7 5422.3 5429.5 3268.6 3272.4 3327.2 3345.5 3380.7 1009.4 1022.1 1041.3 1055.0 1085.2 12398.0 12413.6 12472.3 12500.5 12503.4 4601.7 4668.6 4742.1 4756.4 4756.9 9647.6 9677.8 9713.2 9733.1 9742.0 5216.1 5219.5 5225.3 5276.9 5292.4 4216.6 4819.7 4879.3 4889.5 4924.1 3630.5 3687.0 3692.9 3722.1 3764.3 1091.4 1097.4 1103.1 1128.9 1132.2 1221.5 1244.3 1251.0 1488.0 1491.7 8197.0 8373.5 8377.7 8402.3 8434.7 524.9 531.6 532.8 535.2 537.6 5861.2 5890.8 5902.9 5946.2 5951.8 10012.4 10264.3 10279.6 10352.0 10453.4 9974.5 10168.1 10169.9 10190.8 10195.4 8284.6 8464.8 8523.8 8531.1 8536.5 8253.1 8271.3 8362.4 8387.7 8459.0 9390.9 9575.5 9579.9 9741.1 9786.6 9087.2 9610.7 9633.2 9791.0 10058.8 7214.2 7819.0 8062.4 8079.4 8215.8 8124.1 8175.0 8178.7 8212.3 8231.5 7126.0 7313.2 7428.6 7450.6 7589.9 7372.6 7379.5 7386.9 7464.0 7529.1 7843.0 7847.9 7902.6 7903.5 7913.0 7119.3 7188.7 7192.4 7337.8 7345.4 7038.1 7092.7 7129.9 7157.5 7206.7 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | [#4] prototype.html Cycles:180 Average:5367.91 Median:6085.68 stddev:1597.17 (26.2%) stddev-sans-first:1556.73 10:16:58 INFO - PROCESS | 17097 | Values: 356.8 360.5 362.7 363.3 373.1 6007.8 6020.8 6057.0 6059.3 6071.8 5961.0 5966.6 5973.5 5978.3 6003.9 4455.8 4578.2 4680.0 4681.4 4700.3 4680.6 4690.9 4699.3 4704.0 4711.6 4640.1 4655.2 4663.7 4665.0 4673.9 4436.7 4514.2 4637.5 4655.3 4672.9 4118.0 4128.4 4132.6 4134.8 4139.1 5675.4 5690.4 5690.5 5698.8 5704.4 5422.6 5442.3 5459.0 5461.5 5463.5 6325.1 6336.1 6350.8 6354.0 6356.0 4295.3 4470.9 4490.3 4505.7 4610.2 6575.8 6636.9 6639.9 6642.5 6649.2 4608.4 4616.0 4617.9 4620.8 4623.8 4686.2 4686.4 4687.2 4689.8 4690.4 5376.2 5386.4 5387.5 5389.3 5391.5 6266.9 6404.1 6414.8 6423.5 6426.2 1622.1 1634.9 1637.6 1637.8 1642.2 1021.3 1077.6 1100.3 1144.9 1169.5 6095.5 6102.9 6109.1 6114.2 6120.8 6467.5 6516.8 6557.5 6558.9 6563.5 6184.8 6187.8 6191.6 6192.6 6197.4 3510.8 3541.9 3552.5 3555.7 3557.4 6669.1 6672.5 6796.8 6800.6 6815.4 6673.5 6678.7 6693.2 6699.0 6701.8 6747.0 6768.5 6790.0 6791.8 6794.5 6533.4 6533.9 6544.2 6544.8 6557.3 6292.9 6405.6 6422.0 6544.6 6586.1 6899.0 6917.6 6929.4 6933.5 6955.2 4581.4 4620.7 4631.2 4639.1 4639.5 6656.4 6661.9 6665.7 6678.5 6679.2 6333.9 6449.3 6459.6 6462.5 6481.9 6443.1 6460.2 6467.4 6471.4 6481.5 6317.1 6327.7 6336.3 6341.2 6347.6 6475.3 6489.1 6490.1 6497.7 6505.9 6075.9 6165.6 6259.5 6322.7 6342.2 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - PROCESS | 17097 | [#5] yui.html Cycles:180 Average:14111.94 Median:25423.90 stddev:16216.10 (63.8%) stddev-sans-first:16230.91 10:16:58 INFO - PROCESS | 17097 | Values: 827.7 892.7 903.7 906.6 914.7 14531.1 14817.8 14870.6 14935.0 14959.9 12172.8 13786.2 13935.7 13939.5 13948.5 914.3 938.7 941.3 941.4 941.9 909.3 909.4 913.1 916.7 917.5 796.8 952.0 959.2 959.4 961.2 797.2 799.1 942.8 961.9 962.9 713.5 714.1 714.5 715.1 715.2 14630.5 14658.5 14666.6 14666.8 14669.0 12899.4 13419.7 14449.9 14507.3 14756.2 10917.5 10918.9 10938.8 11036.3 11102.2 3934.4 3945.7 3973.7 3975.7 4018.0 51007.3 51115.7 51834.5 52162.0 52873.0 11351.3 11381.1 11512.4 11643.3 11750.2 20405.9 20412.5 20434.1 20453.3 20459.7 7734.9 7956.5 8044.8 8057.2 8554.5 4486.9 4597.4 4651.7 4675.3 4827.6 3330.1 3345.8 3360.5 3375.0 3393.6 549.9 598.0 620.6 621.5 633.3 586.9 642.2 677.2 686.8 734.5 7623.2 7641.9 7654.6 7706.6 7755.0 692.8 692.9 698.5 700.5 705.2 3736.4 3872.9 3893.4 4023.4 4028.0 57117.4 57885.0 57940.0 58697.7 59373.7 51246.0 51647.0 51660.5 52232.2 52495.0 44341.0 45887.0 46015.8 46196.1 46690.0 7670.8 7755.1 7884.3 7903.6 8112.4 34918.7 35219.5 36049.3 36410.5 37070.4 43041.8 43392.1 43730.6 43809.0 43846.0 10333.1 10587.4 10658.2 10960.2 10996.2 10755.6 10928.6 11224.2 11579.6 12072.1 10340.4 11073.5 11176.7 11398.8 11553.8 10382.3 10383.0 10404.0 10594.6 10682.4 11160.2 11180.1 11211.6 11241.4 12380.8 9416.2 9452.5 9590.2 9832.6 9909.8 9353.2 9410.3 9420.1 9436.5 9529.8 10:16:58 INFO - PROCESS | 17097 | -------- Summary: end -------- 10:16:58 INFO - PROCESS | 17097 | 10:16:58 INFO - TEST-INFO | 17097: exit 0 10:16:59 INFO - TEST-OK | dromaeo_css | took 1114241ms 10:16:59 INFO - TEST-START | kraken 10:16:59 INFO - operating with platform_type : linux_ 10:16:59 INFO - Initialising browser for kraken test... 10:16:59 INFO - TEST-INFO | started process 17376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX3aShp/profile http://localhost:60221/getInfo.html) 10:17:04 INFO - PROCESS | 17376 | __metrics Screen width/height:1600/1200 10:17:04 INFO - PROCESS | 17376 | colorDepth:24 10:17:04 INFO - PROCESS | 17376 | Browser inner width/height: 1024/697 10:17:04 INFO - PROCESS | 17376 | __metrics 10:17:05 INFO - PROCESS | 17376 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:06 INFO - TEST-INFO | 17376: exit 0 10:17:06 INFO - Browser initialized. 10:17:06 INFO - Running cycle 1/1 for kraken test... 10:17:06 INFO - TEST-INFO | started process 17470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX3aShp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:18 INFO - PROCESS | 17470 | RSS: Main: 139206656 10:17:18 INFO - PROCESS | 17470 | 10:17:20 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60221/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:21 INFO - PROCESS | 17470 | RSS: Main: 183599104 10:17:21 INFO - PROCESS | 17470 | 10:17:23 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60221/tests/kraken/driver.html?testName=audio-dft) 10:17:24 INFO - PROCESS | 17470 | RSS: Main: 175325184 10:17:24 INFO - PROCESS | 17470 | 10:17:27 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60221/tests/kraken/driver.html?testName=audio-fft) 10:17:27 INFO - PROCESS | 17470 | RSS: Main: 175132672 10:17:27 INFO - PROCESS | 17470 | 10:17:29 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60221/tests/kraken/driver.html?testName=audio-oscillator) 10:17:30 INFO - PROCESS | 17470 | RSS: Main: 175923200 10:17:30 INFO - PROCESS | 17470 | 10:17:32 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60221/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:33 INFO - PROCESS | 17470 | RSS: Main: 174690304 10:17:33 INFO - PROCESS | 17470 | 10:17:36 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60221/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:36 INFO - PROCESS | 17470 | RSS: Main: 174718976 10:17:36 INFO - PROCESS | 17470 | 10:17:40 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60221/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:40 INFO - PROCESS | 17470 | RSS: Main: 174690304 10:17:40 INFO - PROCESS | 17470 | 10:17:43 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60221/tests/kraken/driver.html?testName=json-parse-financial) 10:17:44 INFO - PROCESS | 17470 | RSS: Main: 174727168 10:17:44 INFO - PROCESS | 17470 | 10:17:45 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60221/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:46 INFO - PROCESS | 17470 | RSS: Main: 181616640 10:17:46 INFO - PROCESS | 17470 | 10:17:47 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60221/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:48 INFO - PROCESS | 17470 | RSS: Main: 179691520 10:17:48 INFO - PROCESS | 17470 | 10:17:50 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60221/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:51 INFO - PROCESS | 17470 | RSS: Main: 184086528 10:17:51 INFO - PROCESS | 17470 | 10:17:53 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:54 INFO - PROCESS | 17470 | RSS: Main: 187183104 10:17:54 INFO - PROCESS | 17470 | 10:17:56 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:57 INFO - PROCESS | 17470 | RSS: Main: 186224640 10:17:57 INFO - PROCESS | 17470 | 10:17:58 INFO - PROCESS | 17470 | Cycle 1(1): loaded http://localhost:60221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60221/tests/kraken/driver.html?testName=ai-astar) 10:17:59 INFO - PROCESS | 17470 | RSS: Main: 248438784 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | __start_tp_report 10:17:59 INFO - PROCESS | 17470 | _x_x_mozilla_page_load 10:17:59 INFO - PROCESS | 17470 | _x_x_mozilla_page_load_details 10:17:59 INFO - PROCESS | 17470 | |i|pagename|runs| 10:17:59 INFO - PROCESS | 17470 | |0;ai-astar;112;111;111;112;110;109;110;110;110;123 10:17:59 INFO - PROCESS | 17470 | |1;audio-beat-detection;153;133;152;169;137;154;161;129;169;128 10:17:59 INFO - PROCESS | 17470 | |2;audio-dft;160;162;160;161;160;161;161;160;160;160 10:17:59 INFO - PROCESS | 17470 | |3;audio-fft;77;76;76;165;76;75;76;76;174;73 10:17:59 INFO - PROCESS | 17470 | |4;audio-oscillator;93;93;153;93;93;93;150;94;94;142 10:17:59 INFO - PROCESS | 17470 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 10:17:59 INFO - PROCESS | 17470 | |6;imaging-darkroom;148;146;146;146;147;146;146;147;147;145 10:17:59 INFO - PROCESS | 17470 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 10:17:59 INFO - PROCESS | 17470 | |8;json-parse-financial;53;55;56;54;54;54;53;53;66;53 10:17:59 INFO - PROCESS | 17470 | |9;json-stringify-tinderbox;64;64;63;73;64;63;64;64;63;64 10:17:59 INFO - PROCESS | 17470 | |10;stanford-crypto-aes;77;77;86;78;79;79;87;80;80;80 10:17:59 INFO - PROCESS | 17470 | |11;stanford-crypto-ccm;115;113;129;117;120;110;114;112;111;112 10:17:59 INFO - PROCESS | 17470 | |12;stanford-crypto-pbkdf2;140;142;136;144;136;135;145;146;147;138 10:17:59 INFO - PROCESS | 17470 | |13;stanford-crypto-sha256-iterative;68;68;70;68;69;65;67;67;67;66 10:17:59 INFO - PROCESS | 17470 | __end_tp_report 10:17:59 INFO - PROCESS | 17470 | __start_cc_report 10:17:59 INFO - PROCESS | 17470 | _x_x_mozilla_cycle_collect,1050 10:17:59 INFO - PROCESS | 17470 | __end_cc_report 10:17:59 INFO - PROCESS | 17470 | __startTimestamp1464196679060__endTimestamp 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | ------- Summary: start ------- 10:17:59 INFO - PROCESS | 17470 | Number of tests: 14 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:4.05 (3.6%) stddev-sans-first:4.29 10:17:59 INFO - PROCESS | 17470 | Values: 112.0 111.0 111.0 112.0 110.0 109.0 110.0 110.0 110.0 123.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.50 stddev:15.75 (10.3%) stddev-sans-first:16.62 10:17:59 INFO - PROCESS | 17470 | Values: 153.0 133.0 152.0 169.0 137.0 154.0 161.0 129.0 169.0 128.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 10:17:59 INFO - PROCESS | 17470 | Values: 160.0 162.0 160.0 161.0 160.0 161.0 161.0 160.0 160.0 160.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:39.65 (52.2%) stddev-sans-first:41.55 10:17:59 INFO - PROCESS | 17470 | Values: 77.0 76.0 76.0 165.0 76.0 75.0 76.0 76.0 174.0 73.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:26.73 (28.7%) stddev-sans-first:27.65 10:17:59 INFO - PROCESS | 17470 | Values: 93.0 93.0 153.0 93.0 93.0 93.0 150.0 94.0 94.0 142.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:17:59 INFO - PROCESS | 17470 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 10:17:59 INFO - PROCESS | 17470 | Values: 148.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 145.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:17:59 INFO - PROCESS | 17470 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.00 stddev:3.96 (7.3%) stddev-sans-first:4.12 10:17:59 INFO - PROCESS | 17470 | Values: 53.0 55.0 56.0 54.0 54.0 54.0 53.0 53.0 66.0 53.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.00 stddev:2.99 (4.7%) stddev-sans-first:3.16 10:17:59 INFO - PROCESS | 17470 | Values: 64.0 64.0 63.0 73.0 64.0 63.0 64.0 64.0 63.0 64.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:3.47 (4.3%) stddev-sans-first:3.46 10:17:59 INFO - PROCESS | 17470 | Values: 77.0 77.0 86.0 78.0 79.0 79.0 87.0 80.0 80.0 80.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:114.50 stddev:5.66 (4.9%) stddev-sans-first:6.00 10:17:59 INFO - PROCESS | 17470 | Values: 115.0 113.0 129.0 117.0 120.0 110.0 114.0 112.0 111.0 112.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:143.00 stddev:4.51 (3.2%) stddev-sans-first:4.77 10:17:59 INFO - PROCESS | 17470 | Values: 140.0 142.0 136.0 144.0 136.0 135.0 145.0 146.0 147.0 138.0 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - PROCESS | 17470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 10:17:59 INFO - PROCESS | 17470 | Values: 68.0 68.0 70.0 68.0 69.0 65.0 67.0 67.0 67.0 66.0 10:17:59 INFO - PROCESS | 17470 | -------- Summary: end -------- 10:17:59 INFO - PROCESS | 17470 | 10:17:59 INFO - TEST-INFO | 17470: exit 0 10:18:00 INFO - TEST-OK | kraken | took 61022ms 10:18:00 INFO - SUITE-END | took 1175s 10:18:00 INFO - Completed test suite (00:19:35) 10:18:00 INFO - javascript benchmark 10:18:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3296.1100502864224, 3334.81658508782, 3344.665533446654, 3370.831458427078, 3382.424987752082, 5434.212039254306, 5447.373552041517, 5450.236966824647, 5469.0, 5478.616496845222, 5459.372172200198, 5477.5070243678065, 5484.698341591211, 5485.067538518451, 5511.724413779305, 4817.373741413611, 4983.0, 5004.699718016913, 5073.061483625541, 5103.157978933472, 4951.579115775164, 5045.520675535819, 5052.0, 5053.444121146671, 5055.77249023793, 5013.097642424362, 5046.772895219706, 5078.8730281743065, 5082.364704411949, 5082.644214904958, 5044.772985215655, 5089.949100509021, 5101.20931255656, 5103.693778373309, 5123.564497017758, 4910.091633047898, 4945.0, 5013.799448022075, 5014.147594908874, 5049.065922804293, 5317.548008419289, 5343.706096164709, 5349.919751203735, 5358.785648574052, 5365.812196573141, 5769.1923130761725, 5881.823545293648, 5920.881582368372, 5927.1405646181065, 5957.434043765836, 5872.911906321408, 5911.55663325248, 5945.64326140433, 5950.107483877453, 5961.791337303173, 5461.563074953994, 5519.641223320471, 5520.503154716095, 5522.0336441122645, 5523.0, 5893.057110862242, 5999.610025348338, 6014.308354539196, 6029.668368239789, 6081.422264884829, 5692.31692196939, 5703.572232082611, 5704.34400043992, 5704.401037890962, 5711.828645140652, 5788.27646544182, 5798.739056742456, 5803.332616749043, 5804.04233301509, 5811.186433899257, 5672.517835983987, 5739.684317362585, 5832.270966129234, 5925.318588362307, 5933.110033495011, 5779.595428319977, 5782.59521833476, 5783.074708046693, 5786.247787787561, 5788.971055144697, 4444.9998750281575, 4450.821967121344, 4452.0205554777895, 4457.68796184264, 4477.3731677565165, 3962.465067215889, 4005.5794141615293, 4049.7367671101283, 4056.472658554428, 4088.12105397341, 5569.582281328917, 5582.078956972054, 5594.776208951596, 5597.188407680864, 5636.887262254732, 5749.741261643236, 5776.537876969833, 5873.3832947539895, 5883.264591926009, 5887.293524777054, 5626.690532020696, 5649.858753531194, 5664.178694089416, 5673.432656734293, 5709.0, 5099.413567439792, 5105.0, 5132.717700526432, 5133.050385678662, 5169.302144210558, 5867.090600956859, 5993.760249590055, 6154.876902462015, 6156.168917196211, 6158.3841615838055, 5926.555508336805, 5944.613600115978, 5949.3753155918, 5955.017422125301, 5979.4917432018765, 6065.6663883486835, 6068.969655151873, 6084.695765211633, 6086.843499735036, 6122.846928826815, 5713.971430142823, 5786.623869448473, 5844.561657875592, 5847.707614619167, 5856.297244330537, 5915.615484993462, 5944.108383742473, 5946.345901950695, 5951.315598706031, 5967.791127310524, 5739.139129130664, 5793.478586927196, 5794.246747922743, 5798.449147330997, 5800.796972105956, 5560.694161821139, 5708.514776244066, 5759.078547432391, 5768.769249229984, 5807.506361959281, 5647.661140331593, 5654.46282603152, 5655.208270842003, 5665.291838520185, 5669.6314739541795, 5775.306963164279, 5792.304923409218, 5793.652380857162, 5793.884122317446, 5797.739101740347, 5490.231367608458, 5530.668159910419, 5612.326520817528, 5630.493255606852, 5692.886142277214], "unit": "score", "name": "dojo.html", "value": 5427.492148617182}, {"lowerIsBetter": false, "replicates": [543.3181357396468, 547.7179252684865, 561.7275621323658, 569.1320735877788, 575.6114622629724, 40492.59507404925, 41608.0, 41633.58366416339, 41710.0, 41720.0, 45442.31836522446, 46205.30692039622, 46256.53743462573, 46304.76847615757, 46330.53669463305, 8835.851339325895, 9020.188183063523, 9030.729078127666, 9041.819163616723, 9042.231410330098, 8810.207081362676, 8950.14973577509, 8950.149735775123, 9186.311026672993, 9197.356185067049, 9189.908100919005, 9227.3079519036, 9267.768305792342, 9276.072392760738, 9281.257499400032, 9088.182063614273, 9158.129977652112, 9173.862392064124, 9194.862077068849, 9195.126462986005, 9090.318226133, 9210.585523651453, 9242.907570924339, 9245.953770231106, 9246.214071803905, 44542.777286113684, 45033.09933801338, 45067.323990140176, 45250.321245181345, 45275.32087018697, 3802.0874990002476, 3851.614838516154, 3913.9804300978312, 3955.5451123120633, 4262.403263543107, 32783.50824737631, 33333.6666633333, 33573.32853342944, 34342.65657343445, 34869.30261394783, 3950.2889479893606, 3985.6811455083525, 3989.5238761658084, 4033.3143365627916, 4051.0885050863612, 235091.0, 235724.0, 235993.0, 236850.0, 237654.0, 63898.68050659717, 65226.34773652298, 65227.67386163134, 65387.0, 65406.0, 74779.0, 75249.0, 75580.62209689026, 75640.0, 75689.0, 16201.4329498467, 16452.341906323614, 16585.087820169767, 16621.0, 16621.584460388585, 13366.0, 13412.530561430303, 13444.193348399127, 13446.058775885595, 13467.461301548024, 21948.34154975353, 22154.113835446726, 22206.0, 22215.0, 23288.06847726072, 7825.256600622932, 7991.600419978978, 8092.514449132953, 8123.222701443857, 8193.286720246786, 952.7760976170595, 1018.5467466977273, 1103.5751235774123, 1144.2733863996257, 1144.9942750286195, 30984.0704778857, 31025.8448707755, 31112.0, 31523.527147092813, 31629.0, 1091.939943303126, 1145.4673576786834, 1174.4362705901215, 1189.1259923955886, 1205.8854408831146, 14480.0, 14609.78085328721, 14663.28982401458, 14709.632259193391, 15037.172955487553, 335335.0, 335609.0, 336589.0, 337624.0, 337973.0, 60086.09870851941, 60777.39222607806, 60818.391816082156, 60842.69578652078, 60867.39132608706, 1239.1202246405153, 1365.481117175467, 1373.4986729843736, 1425.2944792327864, 1476.0922032949659, 27990.0, 28153.859230703714, 28431.43137137287, 28978.985735499155, 28993.565096523147, 43854.34218486661, 44318.77840610905, 44595.10809783851, 44627.0, 44649.33026004677, 221397.0, 222787.0, 223491.0, 223516.0, 223595.0, 30705.385892282477, 35121.0, 35709.0, 35885.461718073726, 36731.81634091812, 42017.78991105025, 43105.56894431016, 43400.34899476447, 43783.78108109439, 43914.78042609766, 36042.8197859009, 36608.81695591505, 37969.810150949066, 38892.2221555573, 38955.805220973714, 37464.0, 38110.428343575426, 38435.6156438432, 38735.0, 38978.6102138975, 37760.0, 38775.2244955105, 38844.0, 39178.80410597929, 39332.2133557333, 34115.31769364549, 35060.64939350574, 35181.29637407186, 35519.0, 35628.0, 26506.337341566614, 26570.86714566492, 26729.33176670599, 26790.330241744112, 26865.865670671523], "unit": "score", "name": "ext.html", "value": 19490.381954060424}, {"lowerIsBetter": false, "replicates": [380.68022860796924, 384.44447772968056, 384.450236162288, 390.07357525876046, 398.8384704194802, 17639.382621608245, 18314.26742930283, 18778.530536736587, 18874.52813679655, 18897.71653425198, 17566.560835979075, 17913.373031943884, 17914.82085179148, 17958.91020544899, 18248.452546423596, 5511.338639363282, 5751.0, 5779.046457334534, 5793.507551858097, 5795.449432303945, 4243.957560424387, 5929.940700593003, 6143.969280153616, 6174.722137503801, 6185.072239164117, 5970.223870896777, 6108.205933228674, 6124.938750612481, 6147.323794382637, 6156.692165391735, 6250.0, 6256.1866957295715, 6272.529560282974, 6276.529260305495, 6281.560290779625, 3846.288436639231, 5208.401033881077, 5404.972975135099, 5417.241586177938, 5427.891442171174, 21602.0, 21638.783612163836, 22120.88939555292, 23143.0742770289, 23158.76841231583, 2445.461998360358, 2552.680914885639, 2556.2586849813533, 2770.4182121754457, 3160.8893688721014, 14077.296135193199, 14537.709245815131, 14573.6356591085, 14779.778303325458, 15267.0, 1847.9538011549685, 1985.8907760073191, 2070.7204527388762, 2116.3968269043403, 2145.7639659637425, 65255.0, 74986.62506687432, 81460.59269703673, 84277.0, 84850.57574712149, 14933.925330373278, 14978.325975330918, 15429.22853857325, 15444.613884652974, 15570.9221453892, 27976.86011569929, 28334.71665283321, 28455.71544284572, 28486.0, 28576.285592860346, 8926.241269492166, 9142.497162655985, 9172.082791720775, 9281.350305478552, 9307.395019323721, 7873.0, 7892.0, 7922.049354077548, 8047.959760201162, 8195.877061844078, 7845.0, 7953.840923181504, 7980.600969951479, 8014.799630009296, 8093.635786389626, 2590.1794852592275, 2899.869505872241, 3012.9698703013128, 3019.9547006794915, 3224.613046434396, 991.6281394477071, 1011.4740335025746, 1086.9293495922739, 1105.922585419029, 1115.3642423818346, 17184.570385740208, 17230.65538689219, 17408.47774566765, 17626.91186544059, 18025.0, 970.2092794372563, 1003.0972125087334, 1035.7514196592763, 1045.926785125034, 1109.4230999880178, 9004.144606262395, 9965.651202207888, 10006.09945104944, 10085.596576136872, 10289.897101029044, 436869.0, 437713.0, 439256.0, 447904.0, 448243.0, 80912.19087809164, 83012.0, 83092.58453707813, 83253.0, 84210.0, 1015.6242190389603, 1020.5152552537485, 1025.0876719719456, 1028.4240825137947, 1036.383351905615, 15755.529326221587, 15826.68346633084, 15873.603159921095, 15894.443694470638, 15909.840901590836, 31622.367552649277, 34427.0, 35548.82225588855, 36778.8161059193, 37065.258694826494, 47195.0, 50838.0, 51090.489095108576, 51164.23253651124, 51360.74319628378, 8421.663133474593, 8444.873326900224, 8446.45098068648, 8572.3999320047, 8756.299496040428, 8777.736667899973, 9909.355891867006, 12842.67893302675, 13120.212787232796, 13225.537106201236, 5397.055515284888, 6064.575479716377, 10404.895951040393, 11366.772664546828, 11585.884141158818, 10813.891861081289, 11246.493907774005, 11660.30038197711, 11861.0, 11942.16404851652, 10457.738556536147, 10502.107320877505, 10526.210534209811, 10600.840987385349, 10736.30214036085, 8388.203120703523, 8725.738227853175, 8738.34462415334, 8930.285577153682, 8978.281737460857, 9259.0, 10499.632512862014, 10557.419341936267, 10586.10018148466, 10845.511951962022], "unit": "score", "name": "jquery.html", "value": 9514.705894612247}, {"lowerIsBetter": false, "replicates": [1377.30446124707, 1560.843915608439, 1593.705164544559, 1828.1681834765184, 1924.3745782620642, 7715.498492597977, 8421.157884211583, 8603.053664096944, 8608.61261243244, 8620.137986201376, 8336.791580210498, 8525.488470691764, 8531.0, 8531.78670533237, 8539.06070332263, 2421.842580232288, 2434.379233295507, 2436.3300092474533, 2449.5590793657134, 2449.595816690253, 2341.519988402373, 2413.5655581995234, 2450.179189971353, 2451.950960980779, 2457.1154384421593, 2441.328634625483, 2451.9754802452017, 2461.4215659320043, 2477.2939712182033, 2479.0207867892173, 2414.2395145529276, 2414.9154779582805, 2437.122635851092, 2446.522928029026, 2449.2407353720314, 2408.0, 2427.8786060696893, 2436.902523899042, 2440.3533063738123, 2443.1937460638123, 8876.8668469973, 8919.063498332647, 8921.776955576097, 8924.419912705653, 8928.553572321423, 5282.630215884889, 5381.139017757179, 5415.729213539346, 5422.267993820823, 5429.53848922842, 3268.5750852389274, 3272.4109660261383, 3327.168207948013, 3345.4647256438852, 3380.678835510623, 1009.3741880034353, 1022.0545994954638, 1041.2919214933843, 1054.984175237372, 1085.2457542008308, 12398.0, 12413.565525206574, 12472.314022728746, 12500.49998000079, 12503.374831258492, 4601.677882548256, 4668.603168730628, 4742.099001189763, 4756.381670382828, 4756.904861902743, 9647.565859536338, 9677.758056048655, 9713.22294216461, 9733.075357840993, 9742.0, 5216.1393370094265, 5219.5041471060185, 5225.294585231021, 5276.894462110737, 5292.391374991848, 4216.578342165821, 4819.746865814844, 4879.341288926021, 4889.462159162489, 4924.089043526959, 3630.49173115764, 3687.0, 3692.8707495237536, 3722.1439069013736, 3764.265968136187, 1091.411995546478, 1097.40191595579, 1103.089950790585, 1128.8927551882557, 1132.1791701016862, 1221.4808706299964, 1244.3467179730715, 1250.956216532417, 1488.0253434000747, 1491.686745783376, 8196.959015204886, 8373.539455330016, 8377.748667539983, 8402.285805706584, 8434.704785332484, 524.8504176309809, 531.6172355903743, 532.8108521474899, 535.162470733309, 537.5914305128131, 5861.17943487912, 5890.823275301748, 5902.8819423611285, 5946.226990491208, 5951.761929522857, 10012.44931528773, 10264.281500294908, 10279.640212592672, 10352.016558426938, 10453.425061621532, 9974.45140517264, 10168.084872361374, 10169.898301016896, 10190.796184076276, 10195.388276703421, 8284.585770711441, 8464.788380290418, 8523.786905327417, 8531.146885311418, 8536.487810731376, 8253.133420990709, 8271.255586997198, 8362.372822038493, 8387.664493420194, 8459.027211870714, 9390.906090939003, 9575.521223938636, 9579.9042009579, 9741.123298903132, 9786.559604817943, 9087.18256348746, 9610.711678649652, 9633.229341652792, 9790.951045244728, 10058.8491172631, 7214.170370407471, 7818.960905195438, 8062.355011599176, 8079.434439589408, 8215.753527394188, 8124.065732440845, 8175.0, 8178.713745018896, 8212.3430125591, 8231.506109633441, 7126.0, 7313.158986716596, 7428.628568571442, 7450.590217538087, 7589.924100758922, 7372.557646541225, 7379.520331178671, 7386.926130738839, 7464.0, 7529.096508419025, 7843.0, 7847.882281765892, 7902.604869756604, 7903.486273392211, 7912.960435198018, 7119.323664251888, 7188.676509556978, 7192.388646965067, 7337.816554585965, 7345.412367010519, 7038.085048943604, 7092.716291348288, 7129.928700713134, 7157.534760240567, 7206.747763828241], "unit": "score", "name": "mootools.html", "value": 4802.103801192165}, {"lowerIsBetter": false, "replicates": [356.77701436602126, 360.53851070629605, 362.711644242827, 363.25895173845356, 373.11757693055915, 6007.8498037549025, 6020.75916963322, 6056.9999999999945, 6059.333473317937, 6071.817845464632, 5961.046232602785, 5966.642001479903, 5973.4623883850445, 5978.252718410199, 6003.939960600393, 4455.799489023002, 4578.153041687298, 4679.953200468003, 4681.414823147098, 4700.294955756647, 4680.5787479126875, 4690.90618187636, 4699.271612899989, 4703.952960470403, 4711.575958163765, 4640.09518143962, 4655.20861453552, 4663.696859704109, 4665.0, 4673.8831529211875, 4436.66724995625, 4514.164879497303, 4637.466691330473, 4655.2784318430695, 4672.929906051412, 4118.0, 4128.380742888561, 4132.586741325874, 4134.834606615732, 4139.110091330378, 5675.375708672084, 5690.374058853523, 5690.48785609293, 5698.772049118072, 5704.429557044304, 5422.6475279106735, 5442.265294185274, 5459.0, 5461.5357694596005, 5463.453654634504, 6325.114483972247, 6336.081268216083, 6350.809475715736, 6354.0, 6356.0, 4295.269804133305, 4470.932936005963, 4490.259107247301, 4505.7296562206375, 4610.239310513761, 6575.769848055343, 6636.900446493307, 6639.86720265592, 6642.501812364092, 6649.235337936151, 4608.423947006624, 4616.030633566921, 4617.861464156081, 4620.838270660578, 4623.791929363187, 4686.156491831435, 4686.367340409001, 4687.226607609774, 4689.7655117244, 4690.366800481959, 5376.1935709643085, 5386.434424385461, 5387.46125387466, 5389.299391079135, 5391.487808658171, 6266.874662506815, 6404.103425520431, 6414.775482858077, 6423.518236132309, 6426.228852537632, 1622.1321592947716, 1634.87738419619, 1637.5987882968511, 1637.8034635843537, 1642.1707037945762, 1021.3361315145066, 1077.6012875236213, 1100.312304809494, 1144.8740638529755, 1169.5438778876246, 6095.451409373089, 6102.908456373158, 6109.083637454418, 6114.2357205349335, 6120.846978825565, 6467.450266727381, 6516.837079073061, 6557.540972131905, 6558.934410655832, 6563.50773691975, 6184.845378865474, 6187.783427580013, 6191.566590338633, 6192.59748116371, 6197.442230199304, 3510.8069056201643, 3541.94687079694, 3552.5381700378784, 3555.6622120898473, 3557.377458944726, 6669.066330713704, 6672.498687795207, 6796.76211332601, 6800.625965571842, 6815.352541508549, 6673.532852700265, 6678.699458524378, 6693.230278517935, 6699.0, 6701.765438209639, 6747.0, 6768.492363072789, 6790.0, 6791.830204245032, 6794.524383293122, 6533.379328963741, 6533.901991470037, 6544.214694236532, 6544.8363790905605, 6557.311482294481, 6292.905606415816, 6405.615663060045, 6422.0, 6544.574602650812, 6586.110875031809, 6899.0, 6917.584944903322, 6929.411000064849, 6933.5493192942295, 6955.156883425795, 4581.404417425713, 4620.653450991122, 4631.235846085493, 4639.118567472169, 4639.4896561377545, 6656.36764507371, 6661.900071498834, 6665.700043498151, 6678.465722742266, 6679.198496180489, 6333.936660633519, 6449.322821103904, 6459.6447195402825, 6462.547621666438, 6481.870362592627, 6443.09796628463, 6460.224773027267, 6467.417932386108, 6471.385218404244, 6481.546291759721, 6317.084022816758, 6327.746890124527, 6336.271328797063, 6341.175647165839, 6347.5556711029785, 6475.3200913903365, 6489.091527186292, 6490.058941453369, 6497.740090396331, 6505.869882602226, 6075.908861367171, 6165.630062196283, 6259.530535209787, 6322.747090116344, 6342.2389313280855], "unit": "score", "name": "prototype.html", "value": 4856.028904843046}, {"lowerIsBetter": false, "replicates": [827.7433995461406, 892.6563273139841, 903.6746771162381, 906.6101576322179, 914.6661468563976, 14531.12813231207, 14817.77773333401, 14870.628234294149, 14935.0, 14959.92520037401, 12172.81740773889, 13786.241756703377, 13935.721285574307, 13939.512117075905, 13948.511802086929, 914.3051281026418, 938.6902322233647, 941.3034354577632, 941.3598752848061, 941.9434833909953, 909.3498148823589, 909.440693973205, 913.1416468519603, 916.6699988004314, 917.5320586500899, 796.8286818334057, 951.9666811661593, 959.1846930109386, 959.357230655459, 961.1733908838428, 797.2227078598349, 799.1449149410133, 942.8302905476977, 961.9086186812242, 962.8651988721584, 713.5183750968076, 714.085969958454, 714.5177005521252, 715.1346870286959, 715.2239819795528, 14630.487932922297, 14658.486952956702, 14666.63333416673, 14666.779998300033, 14669.0, 12899.419526121346, 13419.66450838727, 14449.942297310006, 14507.347169377403, 14756.188409637465, 10917.454127293604, 10918.890811091867, 10938.781224375547, 11036.282641628268, 11102.222844400896, 3934.3901695236996, 3945.684345252373, 3973.721839471238, 3975.6819454443576, 4017.995501124719, 51007.28761106097, 51115.74442127765, 51834.48165518334, 52162.0, 52873.0, 11351.318920864775, 11381.089512838953, 11512.424378781028, 11643.301401915744, 11750.23623464472, 20405.897970510054, 20412.48968775763, 20434.080466379048, 20453.2841350552, 20459.693104603444, 7734.883976740353, 7956.522608643384, 8044.839103217902, 8057.153998830156, 8554.486730796172, 4486.910261794746, 4597.379353787196, 4651.720896746138, 4675.29870519418, 4827.589654879374, 3330.1008727643402, 3345.832708364572, 3360.5295258663805, 3375.0, 3393.609734880471, 549.8762778374834, 597.979070732531, 620.5563022438978, 621.5276389943675, 633.2559242889587, 586.9471747542742, 642.2004604267623, 677.1704661789367, 686.8111269400855, 734.4931996922106, 7623.16145224036, 7641.923580764233, 7654.617269136521, 7706.576138312446, 7755.0, 692.7644600835639, 692.9480288978347, 698.5354739098443, 700.4606453031138, 705.1502938958542, 3736.4021756518828, 3872.9031774205305, 3893.4354518594646, 4023.3964905264443, 4028.0, 57117.42882571204, 57885.0, 57940.0, 58697.70651146717, 59373.703131484064, 51246.0, 51647.0, 51660.48339516557, 52232.216516752276, 52495.0, 44341.0, 45887.0, 46015.76992115085, 46196.07607847824, 46690.0, 7670.7698769037015, 7755.146933837386, 7884.250996155356, 7903.644336005009, 8112.391570632109, 34918.65081349154, 35219.47170792492, 36049.27901441904, 36410.45384319184, 37070.44394334033, 43041.78479107584, 43392.13215735731, 43730.562694372646, 43809.0, 43846.0, 10333.070023697903, 10587.364758114538, 10658.200634952254, 10960.232783705063, 10996.175286853679, 10755.569777209137, 10928.617498387519, 11224.214304998899, 11579.594714184963, 12072.094592905743, 10340.37957722539, 11073.50169242402, 11176.72058198519, 11398.829017564909, 11553.768924621629, 10382.3251488653, 10383.0, 10404.0, 10594.629187978384, 10682.412467314372, 11160.162987775788, 11180.10559155282, 11211.55153793839, 11241.381724005258, 12380.81428778587, 9416.199623032118, 9452.480113593818, 9590.232781377334, 9832.55753491109, 9909.752256193653, 9353.158215760614, 9410.29422793307, 9420.057994200524, 9436.480993545421, 9529.809403811747], "unit": "score", "name": "yui.html", "value": 6565.238227720516}], "name": "dromaeo_css", "value": 7322.106644887792}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 111.0, 112.0, 110.0, 109.0, 110.0, 110.0, 110.0, 123.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [153.0, 133.0, 152.0, 169.0, 137.0, 154.0, 161.0, 129.0, 169.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 76.0, 165.0, 76.0, 75.0, 76.0, 76.0, 174.0, 73.0], "unit": "score", "name": "audio-fft", "value": 94.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 153.0, 93.0, 93.0, 93.0, 150.0, 94.0, 94.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 56.0, 54.0, 54.0, 54.0, 53.0, 53.0, 66.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 73.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 86.0, 78.0, 79.0, 79.0, 87.0, 80.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [115.0, 113.0, 129.0, 117.0, 120.0, 110.0, 114.0, 112.0, 111.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.3}, {"lowerIsBetter": true, "replicates": [140.0, 142.0, 136.0, 144.0, 136.0, 135.0, 145.0, 146.0, 147.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 68.0, 69.0, 65.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1506.9999999999998}]} 10:18:00 INFO - Return code: 0 10:18:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:18:00 INFO - # TBPL SUCCESS # 10:18:00 INFO - Running post-action listener: _resource_record_post_action 10:18:00 INFO - Running post-run listener: _resource_record_post_run 10:18:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 1622016; Write bytes: 456396800; Read time: 460; Write time: 786744 10:18:01 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 0; Write bytes: 238292992; Read time: 0; Write time: 502012 10:18:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 1622016; Write bytes: 218103808; Read time: 460; Write time: 284732 10:18:01 INFO - Running post-run listener: _upload_blobber_files 10:18:01 INFO - Blob upload gear active. 10:18:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:18:01 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:02 INFO - (blobuploader) - INFO - Done attempting. 10:18:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:03 INFO - (blobuploader) - INFO - Done attempting. 10:18:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:03 INFO - Return code: 0 10:18:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a14bf2f330fdee95dc344acc37b9b890389cecf7a3aa0e023135333bccb44cb60d6ca903fb52b58d6dc5df3971794f54ada2256fbe9700a3d30261526e38ab17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d82d643868f7e9e3b65128cb3006820085905c06a8d1d759a4834a5e5d99c44bd03eb3ccd54aa2c1fffa56851bf2bb1d3cfbb53876940f09a4c90d144e20ecf3"} 10:18:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:03 INFO - Contents: 10:18:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a14bf2f330fdee95dc344acc37b9b890389cecf7a3aa0e023135333bccb44cb60d6ca903fb52b58d6dc5df3971794f54ada2256fbe9700a3d30261526e38ab17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d82d643868f7e9e3b65128cb3006820085905c06a8d1d759a4834a5e5d99c44bd03eb3ccd54aa2c1fffa56851bf2bb1d3cfbb53876940f09a4c90d144e20ecf3"} 10:18:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:03 INFO - Copying logs to upload dir... 10:18:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.030459 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-25 10:18:03.542373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 10:18:03.547146) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a14bf2f330fdee95dc344acc37b9b890389cecf7a3aa0e023135333bccb44cb60d6ca903fb52b58d6dc5df3971794f54ada2256fbe9700a3d30261526e38ab17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d82d643868f7e9e3b65128cb3006820085905c06a8d1d759a4834a5e5d99c44bd03eb3ccd54aa2c1fffa56851bf2bb1d3cfbb53876940f09a4c90d144e20ecf3"} build_url:https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/Og2cMAOPQxC4QziYo6rJmg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a14bf2f330fdee95dc344acc37b9b890389cecf7a3aa0e023135333bccb44cb60d6ca903fb52b58d6dc5df3971794f54ada2256fbe9700a3d30261526e38ab17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d82d643868f7e9e3b65128cb3006820085905c06a8d1d759a4834a5e5d99c44bd03eb3ccd54aa2c1fffa56851bf2bb1d3cfbb53876940f09a4c90d144e20ecf3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 10:18:03.580085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:18:03.580481) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464195230.683404-1354735621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 10:18:03.867524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 10:18:03.870962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 10:18:03.871355) ========= ========= Total master_lag: 0.80 =========