builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1460680273.33 results: success (0) buildid: 20160414165245 builduid: 0b042bda1e42440683754078110f2496 revision: e595db332894e0d6a2bacd793f792d56ce3960d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:13.331435) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:13.332038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:13.332535) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:13.349506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:13.349869) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 17:31:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.1K=0.2s 2016-04-14 17:31:14 (58.1 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.297973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:13.665203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:13.665496) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022791 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:13.719280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 17:31:13.719627) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e595db332894e0d6a2bacd793f792d56ce3960d1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e595db332894e0d6a2bacd793f792d56ce3960d1 --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=97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 17:31:14,760 truncating revision to first 12 chars 2016-04-14 17:31:14,760 Setting DEBUG logging. 2016-04-14 17:31:14,760 attempt 1/10 2016-04-14 17:31:14,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e595db332894?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 17:31:15,568 unpacking tar archive at: fx-team-e595db332894/testing/mozharness/ program finished with exit code 0 elapsedTime=1.100194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 17:31:14.835380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:14.835712) ========= script_repo_revision: e595db332894e0d6a2bacd793f792d56ce3960d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:14.836159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:14.836452) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 17:31:14.847690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-14 17:31:14.848253) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:31:15 INFO - MultiFileLogger online at 20160414 17:31:15 in /builds/slave/test 17:31:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:31:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:31:15 INFO - {'append_to_log': False, 17:31:15 INFO - 'base_work_dir': '/builds/slave/test', 17:31:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:31:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:31:15 INFO - 'branch': 'Fx-Team-Non-PGO', 17:31:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:31:15 INFO - 'config_files': ('talos/linux_config.py',), 17:31:15 INFO - 'default_actions': ('clobber', 17:31:15 INFO - 'read-buildbot-config', 17:31:15 INFO - 'download-and-extract', 17:31:15 INFO - 'populate-webroot', 17:31:15 INFO - 'create-virtualenv', 17:31:15 INFO - 'install', 17:31:15 INFO - 'run-tests'), 17:31:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:31:15 INFO - 'download_minidump_stackwalk': True, 17:31:15 INFO - 'download_symbols': 'ondemand', 17:31:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:31:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:31:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:31:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:31:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:31:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:31:15 INFO - 'installer_path': 'installer.exe', 17:31:15 INFO - 'log_level': 'info', 17:31:15 INFO - 'log_name': 'talos', 17:31:15 INFO - 'log_to_console': True, 17:31:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:31:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:31:15 INFO - 'opt_config_files': (), 17:31:15 INFO - 'pip_index': False, 17:31:15 INFO - 'sps_profile': False, 17:31:15 INFO - 'sps_profile_interval': 0, 17:31:15 INFO - 'suite': 'dromaeojs', 17:31:15 INFO - 'system_bits': '32', 17:31:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:31:15 INFO - 'title': 'talos-linux64-ix-068', 17:31:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:31:15 INFO - 'use_talos_json': True, 17:31:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:31:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:31:15 INFO - 'work_dir': 'build'} 17:31:15 INFO - ##### 17:31:15 INFO - ##### Running clobber step. 17:31:15 INFO - ##### 17:31:15 INFO - Running pre-action listener: _resource_record_pre_action 17:31:15 INFO - Running main action method: clobber 17:31:15 INFO - rmtree: /builds/slave/test/build 17:31:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:31:16 INFO - Running post-action listener: _resource_record_post_action 17:31:16 INFO - ##### 17:31:16 INFO - ##### Running read-buildbot-config step. 17:31:16 INFO - ##### 17:31:16 INFO - Running pre-action listener: _resource_record_pre_action 17:31:16 INFO - Running main action method: read_buildbot_config 17:31:16 INFO - Using buildbot properties: 17:31:16 INFO - { 17:31:16 INFO - "project": "", 17:31:16 INFO - "product": "firefox", 17:31:16 INFO - "script_repo_revision": "production", 17:31:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:31:16 INFO - "repository": "", 17:31:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:31:16 INFO - "buildid": "20160414165245", 17:31:16 INFO - "pgo_build": "False", 17:31:16 INFO - "basedir": "/builds/slave/test", 17:31:16 INFO - "buildnumber": 2836, 17:31:16 INFO - "slavename": "talos-linux64-ix-068", 17:31:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:31:16 INFO - "platform": "ubuntu64_hw", 17:31:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:31:16 INFO - "branch": "fx-team", 17:31:16 INFO - "repo_path": "integration/fx-team", 17:31:16 INFO - "revision": "e595db332894e0d6a2bacd793f792d56ce3960d1", 17:31:16 INFO - "stage_platform": "linux64", 17:31:16 INFO - "builduid": "0b042bda1e42440683754078110f2496", 17:31:16 INFO - "slavebuilddir": "test" 17:31:16 INFO - } 17:31:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:31:16 INFO - Running post-action listener: _resource_record_post_action 17:31:16 INFO - ##### 17:31:16 INFO - ##### Running download-and-extract step. 17:31:16 INFO - ##### 17:31:16 INFO - Running pre-action listener: _resource_record_pre_action 17:31:16 INFO - Running main action method: download_and_extract 17:31:16 INFO - mkdir: /builds/slave/test/build/tests 17:31:16 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')]} 17:31:16 INFO - https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:31:18 INFO - Downloaded 1361 bytes. 17:31:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:31:18 INFO - Using the following test package requirements: 17:31:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:31:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:31:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:31:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:18 INFO - u'jsshell-linux-x86_64.zip'], 17:31:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:31:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:31:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:31:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:31:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:31:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:31:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:18 INFO - https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:31:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:31:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:31:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:31:22 INFO - Downloaded 22202881 bytes. 17:31:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:31:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:31:24 INFO - Return code: 0 17:31:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:31:24 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')]} 17:31:24 INFO - https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:31:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:31:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:31:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:31:32 INFO - Downloaded 22202881 bytes. 17:31:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:31:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:31:33 INFO - Return code: 0 17:31:33 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')]} 17:31:33 INFO - https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:31:34 INFO - Downloaded 10841076 bytes. 17:31:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:31:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:31:35 INFO - Return code: 0 17:31: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')]} 17:31:35 INFO - https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:31:36 INFO - Downloaded 54447925 bytes. 17:31:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:31:36 INFO - mkdir: /builds/slave/test/properties 17:31:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:31:36 INFO - Writing to file /builds/slave/test/properties/build_url 17:31:36 INFO - Contents: 17:31:36 INFO - build_url:https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:31:37 INFO - Running post-action listener: _resource_record_post_action 17:31:37 INFO - Running post-action listener: set_extra_try_arguments 17:31:37 INFO - ##### 17:31:37 INFO - ##### Running populate-webroot step. 17:31:37 INFO - ##### 17:31:37 INFO - Running pre-action listener: _resource_record_pre_action 17:31:37 INFO - Running main action method: populate_webroot 17:31:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:31:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:31:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:31:37 INFO - '--tppagecycles', 17:31:37 INFO - '7'], 17:31:37 INFO - 'tests': ['tsvgm']}}, 17:31:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:31:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:31:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:31:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:31:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:37 INFO - 'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:37 INFO - 'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['damp', 'tps']}, 17:31:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:37 INFO - 'tests': ['damp', 'tps']}, 17:31:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['dromaeo_dom']}, 17:31:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:31:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['a11yr', 17:31:37 INFO - 'ts_paint', 17:31:37 INFO - 'tpaint', 17:31:37 INFO - 'sessionrestore', 17:31:37 INFO - 'sessionrestore_no_auto_restore', 17:31:37 INFO - 'tabpaint']}, 17:31:37 INFO - 'other-e10s': {'tests': ['a11yr', 17:31:37 INFO - 'ts_paint', 17:31:37 INFO - 'tpaint', 17:31:37 INFO - 'sessionrestore', 17:31:37 INFO - 'sessionrestore_no_auto_restore', 17:31:37 INFO - 'tabpaint']}, 17:31:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:31:37 INFO - 'ts_paint', 17:31:37 INFO - 'tpaint', 17:31:37 INFO - 'sessionrestore', 17:31:37 INFO - 'sessionrestore_no_auto_restore', 17:31:37 INFO - 'tabpaint']}, 17:31:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:31:37 INFO - 'ts_paint', 17:31:37 INFO - 'tpaint', 17:31:37 INFO - 'sessionrestore', 17:31:37 INFO - 'sessionrestore_no_auto_restore', 17:31:37 INFO - 'tabpaint']}, 17:31:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['a11yr', 17:31:37 INFO - 'ts_paint', 17:31:37 INFO - 'tpaint', 17:31:37 INFO - 'sessionrestore', 17:31:37 INFO - 'sessionrestore_no_auto_restore', 17:31:37 INFO - 'tabpaint']}, 17:31:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['a11yr', 17:31:37 INFO - 'ts_paint', 17:31:37 INFO - 'tpaint', 17:31:37 INFO - 'sessionrestore', 17:31:37 INFO - 'sessionrestore_no_auto_restore', 17:31:37 INFO - 'tabpaint']}, 17:31:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['tsvgx', 17:31:37 INFO - 'tsvgr_opacity', 17:31:37 INFO - 'tart', 17:31:37 INFO - 'tscrollx', 17:31:37 INFO - 'cart']}, 17:31:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:31:37 INFO - 'tsvgr_opacity', 17:31:37 INFO - 'tart', 17:31:37 INFO - 'tscrollx', 17:31:37 INFO - 'cart']}, 17:31:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:37 INFO - 'talos_options': ['--disable-e10s'], 17:31:37 INFO - 'tests': ['tp5o']}, 17:31:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:37 INFO - 'tests': ['tp5o']}, 17:31:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:37 INFO - 'talos_options': ['--disable-e10s', 17:31:37 INFO - '--xperf_path', 17:31:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:37 INFO - 'tests': ['tp5n']}, 17:31:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:37 INFO - 'talos_options': ['--xperf_path', 17:31:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:37 INFO - 'tests': ['tp5n']}}, 17:31:37 INFO - 'talos.zip': {'path': '', 17:31:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:31:37 INFO - Running post-action listener: _resource_record_post_action 17:31:37 INFO - ##### 17:31:37 INFO - ##### Running create-virtualenv step. 17:31:37 INFO - ##### 17:31:37 INFO - Running pre-action listener: _resource_record_pre_action 17:31:37 INFO - Running main action method: create_virtualenv 17:31:37 INFO - Creating virtualenv /builds/slave/test/build/venv 17:31:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:31:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:31:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:31:37 INFO - Using real prefix '/usr' 17:31:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:31:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:31:40 INFO - Installing pip.................done. 17:31:40 INFO - Return code: 0 17:31:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:31: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')]} 17:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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')]} 17:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:31:40 INFO - Using env: {'DISPLAY': ':0', 17:31:40 INFO - 'HOME': '/home/cltbld', 17:31:40 INFO - 'LANG': 'en_US.UTF-8', 17:31:40 INFO - 'LANGUAGE': 'en_US:en', 17:31:40 INFO - 'LOGNAME': 'cltbld', 17:31:40 INFO - 'MAIL': '/var/mail/cltbld', 17:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:40 INFO - 'MOZ_NO_REMOTE': '1', 17:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:40 INFO - 'NO_EM_RESTART': '1', 17:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:40 INFO - 'PWD': '/builds/slave/test', 17:31:40 INFO - 'SHELL': '/bin/bash', 17:31:40 INFO - 'SHLVL': '1', 17:31:40 INFO - 'TERM': 'linux', 17:31:40 INFO - 'TMOUT': '86400', 17:31:40 INFO - 'USER': 'cltbld', 17:31:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:40 INFO - '_': '/tools/buildbot/bin/python'} 17:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:31:40 INFO - Cleaning up... 17:31:40 INFO - Return code: 0 17:31:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:31: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')]} 17:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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')]} 17:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:31:40 INFO - Using env: {'DISPLAY': ':0', 17:31:40 INFO - 'HOME': '/home/cltbld', 17:31:40 INFO - 'LANG': 'en_US.UTF-8', 17:31:40 INFO - 'LANGUAGE': 'en_US:en', 17:31:40 INFO - 'LOGNAME': 'cltbld', 17:31:40 INFO - 'MAIL': '/var/mail/cltbld', 17:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:40 INFO - 'MOZ_NO_REMOTE': '1', 17:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:40 INFO - 'NO_EM_RESTART': '1', 17:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:40 INFO - 'PWD': '/builds/slave/test', 17:31:40 INFO - 'SHELL': '/bin/bash', 17:31:40 INFO - 'SHLVL': '1', 17:31:40 INFO - 'TERM': 'linux', 17:31:40 INFO - 'TMOUT': '86400', 17:31:40 INFO - 'USER': 'cltbld', 17:31:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:40 INFO - '_': '/tools/buildbot/bin/python'} 17:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:40 INFO - Downloading/unpacking psutil>=0.7.1 17:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:42 INFO - Installing collected packages: psutil 17:31:42 INFO - Running setup.py install for psutil 17:31:42 INFO - building 'psutil._psutil_linux' extension 17:31:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:31:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:31:42 INFO - building 'psutil._psutil_posix' extension 17:31:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:31:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:42 INFO - Successfully installed psutil 17:31:42 INFO - Cleaning up... 17:31:43 INFO - Return code: 0 17:31:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:31: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')]} 17:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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')]} 17:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:31:43 INFO - Using env: {'DISPLAY': ':0', 17:31:43 INFO - 'HOME': '/home/cltbld', 17:31:43 INFO - 'LANG': 'en_US.UTF-8', 17:31:43 INFO - 'LANGUAGE': 'en_US:en', 17:31:43 INFO - 'LOGNAME': 'cltbld', 17:31:43 INFO - 'MAIL': '/var/mail/cltbld', 17:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:43 INFO - 'MOZ_NO_REMOTE': '1', 17:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:43 INFO - 'NO_EM_RESTART': '1', 17:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:43 INFO - 'PWD': '/builds/slave/test', 17:31:43 INFO - 'SHELL': '/bin/bash', 17:31:43 INFO - 'SHLVL': '1', 17:31:43 INFO - 'TERM': 'linux', 17:31:43 INFO - 'TMOUT': '86400', 17:31:43 INFO - 'USER': 'cltbld', 17:31:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:43 INFO - '_': '/tools/buildbot/bin/python'} 17:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:31:45 INFO - Installing collected packages: mozsystemmonitor 17:31:45 INFO - Running setup.py install for mozsystemmonitor 17:31:45 INFO - Successfully installed mozsystemmonitor 17:31:45 INFO - Cleaning up... 17:31:45 INFO - Return code: 0 17:31:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:31:45 INFO - Using env: {'DISPLAY': ':0', 17:31:45 INFO - 'HOME': '/home/cltbld', 17:31:45 INFO - 'LANG': 'en_US.UTF-8', 17:31:45 INFO - 'LANGUAGE': 'en_US:en', 17:31:45 INFO - 'LOGNAME': 'cltbld', 17:31:45 INFO - 'MAIL': '/var/mail/cltbld', 17:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:45 INFO - 'MOZ_NO_REMOTE': '1', 17:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:45 INFO - 'NO_EM_RESTART': '1', 17:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:45 INFO - 'PWD': '/builds/slave/test', 17:31:45 INFO - 'SHELL': '/bin/bash', 17:31:45 INFO - 'SHLVL': '1', 17:31:45 INFO - 'TERM': 'linux', 17:31:45 INFO - 'TMOUT': '86400', 17:31:45 INFO - 'USER': 'cltbld', 17:31:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:45 INFO - '_': '/tools/buildbot/bin/python'} 17:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:45 INFO - Downloading/unpacking blobuploader==1.2.4 17:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:31:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:31:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:48 INFO - Downloading docopt-0.6.1.tar.gz 17:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:31:48 INFO - Installing collected packages: blobuploader, requests, docopt 17:31:48 INFO - Running setup.py install for blobuploader 17:31:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:31:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:31:48 INFO - Running setup.py install for requests 17:31:48 INFO - Running setup.py install for docopt 17:31:48 INFO - Successfully installed blobuploader requests docopt 17:31:48 INFO - Cleaning up... 17:31:48 INFO - Return code: 0 17:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:31:48 INFO - Using env: {'DISPLAY': ':0', 17:31:48 INFO - 'HOME': '/home/cltbld', 17:31:48 INFO - 'LANG': 'en_US.UTF-8', 17:31:48 INFO - 'LANGUAGE': 'en_US:en', 17:31:48 INFO - 'LOGNAME': 'cltbld', 17:31:48 INFO - 'MAIL': '/var/mail/cltbld', 17:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:48 INFO - 'MOZ_NO_REMOTE': '1', 17:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:48 INFO - 'NO_EM_RESTART': '1', 17:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:48 INFO - 'PWD': '/builds/slave/test', 17:31:48 INFO - 'SHELL': '/bin/bash', 17:31:48 INFO - 'SHLVL': '1', 17:31:48 INFO - 'TERM': 'linux', 17:31:48 INFO - 'TMOUT': '86400', 17:31:48 INFO - 'USER': 'cltbld', 17:31:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:48 INFO - '_': '/tools/buildbot/bin/python'} 17:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:48 INFO - Running setup.py (path:/tmp/pip-lcYVUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:49 INFO - Running setup.py (path:/tmp/pip-5hUnhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:49 INFO - Running setup.py (path:/tmp/pip-ZlySYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:49 INFO - Running setup.py (path:/tmp/pip-mK3IFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:49 INFO - Running setup.py (path:/tmp/pip-Wgoy6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:49 INFO - Running setup.py (path:/tmp/pip-txrXuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:49 INFO - Running setup.py (path:/tmp/pip-f83b4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:49 INFO - Running setup.py (path:/tmp/pip-eYzLAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:49 INFO - Running setup.py (path:/tmp/pip-vNvQhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:49 INFO - Running setup.py (path:/tmp/pip-Bj2XN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:49 INFO - Running setup.py (path:/tmp/pip-XwUgiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:49 INFO - Running setup.py (path:/tmp/pip-lRfa8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:49 INFO - Running setup.py (path:/tmp/pip-AhD8Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:49 INFO - Running setup.py (path:/tmp/pip-si_Iyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:49 INFO - Running setup.py (path:/tmp/pip-rfxqg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:50 INFO - Running setup.py (path:/tmp/pip-Ur7ouE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:50 INFO - Running setup.py (path:/tmp/pip-rtM3z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:31:50 INFO - Running setup.py install for manifestparser 17:31:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Running setup.py install for mozcrash 17:31:50 INFO - Running setup.py install for mozdebug 17:31:50 INFO - Running setup.py install for mozdevice 17:31:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Running setup.py install for mozfile 17:31:50 INFO - Running setup.py install for mozhttpd 17:31:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Running setup.py install for mozinfo 17:31:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Running setup.py install for mozInstall 17:31:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:31:50 INFO - Running setup.py install for mozleak 17:31:51 INFO - Running setup.py install for mozlog 17:31:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:31:51 INFO - Running setup.py install for moznetwork 17:31:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:31:51 INFO - Running setup.py install for mozprocess 17:31:51 INFO - Running setup.py install for mozprofile 17:31:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:31:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:31:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:31:51 INFO - Running setup.py install for mozrunner 17:31:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:31:51 INFO - Running setup.py install for mozscreenshot 17:31:51 INFO - Running setup.py install for moztest 17:31:51 INFO - Running setup.py install for mozversion 17:31:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:31:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:31:51 INFO - Cleaning up... 17:31:51 INFO - Return code: 0 17:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31: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')]} 17:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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')]} 17:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:51 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 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:51 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 17:31:51 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 17:31:51 INFO - Using env: {'DISPLAY': ':0', 17:31:51 INFO - 'HOME': '/home/cltbld', 17:31:51 INFO - 'LANG': 'en_US.UTF-8', 17:31:51 INFO - 'LANGUAGE': 'en_US:en', 17:31:51 INFO - 'LOGNAME': 'cltbld', 17:31:51 INFO - 'MAIL': '/var/mail/cltbld', 17:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:51 INFO - 'MOZ_NO_REMOTE': '1', 17:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:51 INFO - 'NO_EM_RESTART': '1', 17:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:51 INFO - 'PWD': '/builds/slave/test', 17:31:51 INFO - 'SHELL': '/bin/bash', 17:31:51 INFO - 'SHLVL': '1', 17:31:51 INFO - 'TERM': 'linux', 17:31:51 INFO - 'TMOUT': '86400', 17:31:51 INFO - 'USER': 'cltbld', 17:31:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:51 INFO - '_': '/tools/buildbot/bin/python'} 17:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:52 INFO - Running setup.py (path:/tmp/pip-sPDKET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:52 INFO - Running setup.py (path:/tmp/pip-7JppUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:52 INFO - Running setup.py (path:/tmp/pip-EFkXp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:52 INFO - Running setup.py (path:/tmp/pip-S2xuMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:52 INFO - Running setup.py (path:/tmp/pip-4Aq1Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:52 INFO - Running setup.py (path:/tmp/pip-SikwNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:52 INFO - Running setup.py (path:/tmp/pip-LB_SR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:52 INFO - Running setup.py (path:/tmp/pip-b9lW2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:52 INFO - Running setup.py (path:/tmp/pip-3cmhdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:52 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)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:52 INFO - Running setup.py (path:/tmp/pip-zOYst4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:52 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)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:52 INFO - Running setup.py (path:/tmp/pip-9VrVJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:52 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)) 17:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:52 INFO - Running setup.py (path:/tmp/pip-5H5WWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:53 INFO - Running setup.py (path:/tmp/pip-LvpVSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:53 INFO - Running setup.py (path:/tmp/pip-sDj5M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:53 INFO - Running setup.py (path:/tmp/pip-0E9vYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:53 INFO - Running setup.py (path:/tmp/pip-6R8Tjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:53 INFO - Running setup.py (path:/tmp/pip-PlF9rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:31:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:55 INFO - Downloading blessings-1.6.tar.gz 17:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:31:55 INFO - Installing collected packages: blessings 17:31:55 INFO - Running setup.py install for blessings 17:31:55 INFO - Successfully installed blessings 17:31:55 INFO - Cleaning up... 17:31:55 INFO - Return code: 0 17:31:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:55 INFO - Reading from file tmpfile_stdout 17:31:55 INFO - Current package versions: 17:31:55 INFO - argparse == 1.2.1 17:31:55 INFO - blessings == 1.6 17:31:55 INFO - blobuploader == 1.2.4 17:31:55 INFO - docopt == 0.6.1 17:31:55 INFO - manifestparser == 1.1 17:31:55 INFO - mozInstall == 1.12 17:31:55 INFO - mozcrash == 0.17 17:31:55 INFO - mozdebug == 0.1 17:31:55 INFO - mozdevice == 0.48 17:31:55 INFO - mozfile == 1.2 17:31:55 INFO - mozhttpd == 0.7 17:31:55 INFO - mozinfo == 0.9 17:31:55 INFO - mozleak == 0.1 17:31:55 INFO - mozlog == 3.1 17:31:55 INFO - moznetwork == 0.27 17:31:55 INFO - mozprocess == 0.22 17:31:55 INFO - mozprofile == 0.28 17:31:55 INFO - mozrunner == 6.11 17:31:55 INFO - mozscreenshot == 0.1 17:31:55 INFO - mozsystemmonitor == 0.0 17:31:55 INFO - moztest == 0.7 17:31:55 INFO - mozversion == 1.4 17:31:55 INFO - psutil == 3.1.1 17:31:55 INFO - requests == 1.2.3 17:31:55 INFO - wsgiref == 0.1.2 17:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:31:55 INFO - Using env: {'DISPLAY': ':0', 17:31:55 INFO - 'HOME': '/home/cltbld', 17:31:55 INFO - 'LANG': 'en_US.UTF-8', 17:31:55 INFO - 'LANGUAGE': 'en_US:en', 17:31:55 INFO - 'LOGNAME': 'cltbld', 17:31:55 INFO - 'MAIL': '/var/mail/cltbld', 17:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:55 INFO - 'MOZ_NO_REMOTE': '1', 17:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:55 INFO - 'NO_EM_RESTART': '1', 17:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:55 INFO - 'PWD': '/builds/slave/test', 17:31:55 INFO - 'SHELL': '/bin/bash', 17:31:55 INFO - 'SHLVL': '1', 17:31:55 INFO - 'TERM': 'linux', 17:31:55 INFO - 'TMOUT': '86400', 17:31:55 INFO - 'USER': 'cltbld', 17:31:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:55 INFO - '_': '/tools/buildbot/bin/python'} 17:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:31:56 INFO - Cleaning up... 17:31:56 INFO - Return code: 0 17:31:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:31:56 INFO - Using env: {'DISPLAY': ':0', 17:31:56 INFO - 'HOME': '/home/cltbld', 17:31:56 INFO - 'LANG': 'en_US.UTF-8', 17:31:56 INFO - 'LANGUAGE': 'en_US:en', 17:31:56 INFO - 'LOGNAME': 'cltbld', 17:31:56 INFO - 'MAIL': '/var/mail/cltbld', 17:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:56 INFO - 'MOZ_NO_REMOTE': '1', 17:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:56 INFO - 'NO_EM_RESTART': '1', 17:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:56 INFO - 'PWD': '/builds/slave/test', 17:31:56 INFO - 'SHELL': '/bin/bash', 17:31:56 INFO - 'SHLVL': '1', 17:31:56 INFO - 'TERM': 'linux', 17:31:56 INFO - 'TMOUT': '86400', 17:31:56 INFO - 'USER': 'cltbld', 17:31:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:56 INFO - '_': '/tools/buildbot/bin/python'} 17:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:56 INFO - Downloading/unpacking jsonschema 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:31:58 INFO - Downloading/unpacking functools32 (from jsonschema) 17:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:31:58 INFO - warning: no files found matching '*.txt' 17:31:58 INFO - no previously-included directories found matching 'build' 17:31:58 INFO - no previously-included directories found matching 'dist' 17:31:58 INFO - no previously-included directories found matching '.git*' 17:31:58 INFO - Installing collected packages: jsonschema, functools32 17:31:58 INFO - Running setup.py install for functools32 17:31:58 INFO - warning: no files found matching '*.txt' 17:31:58 INFO - no previously-included directories found matching 'build' 17:31:58 INFO - no previously-included directories found matching 'dist' 17:31:58 INFO - no previously-included directories found matching '.git*' 17:31:58 INFO - Successfully installed jsonschema functools32 17:31:58 INFO - Cleaning up... 17:31:58 INFO - Return code: 0 17:31:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9cff7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', '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 17:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:31:58 INFO - Using env: {'DISPLAY': ':0', 17:31:58 INFO - 'HOME': '/home/cltbld', 17:31:58 INFO - 'LANG': 'en_US.UTF-8', 17:31:58 INFO - 'LANGUAGE': 'en_US:en', 17:31:58 INFO - 'LOGNAME': 'cltbld', 17:31:58 INFO - 'MAIL': '/var/mail/cltbld', 17:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:58 INFO - 'MOZ_NO_REMOTE': '1', 17:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:58 INFO - 'NO_EM_RESTART': '1', 17:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:58 INFO - 'PWD': '/builds/slave/test', 17:31:58 INFO - 'SHELL': '/bin/bash', 17:31:58 INFO - 'SHLVL': '1', 17:31:58 INFO - 'TERM': 'linux', 17:31:58 INFO - 'TMOUT': '86400', 17:31:58 INFO - 'USER': 'cltbld', 17:31:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:58 INFO - '_': '/tools/buildbot/bin/python'} 17:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:58 INFO - Downloading/unpacking flake8 17:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:32:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:32:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:32:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:32:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:32:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:32:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:32:01 INFO - no previously-included directories found matching 'docs/_build' 17:32:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:32:01 INFO - Running setup.py install for pep8 17:32:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:32:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:32:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:32:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:32:01 INFO - no previously-included directories found matching 'docs/_build' 17:32:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:32:01 INFO - Cleaning up... 17:32:01 INFO - Return code: 0 17:32:01 INFO - Running post-action listener: _resource_record_post_action 17:32:01 INFO - Running post-action listener: _start_resource_monitoring 17:32:01 INFO - Starting resource monitoring. 17:32:01 INFO - ##### 17:32:01 INFO - ##### Running install step. 17:32:01 INFO - ##### 17:32:01 INFO - Running pre-action listener: _resource_record_pre_action 17:32:01 INFO - Running main action method: install 17:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:01 INFO - Reading from file tmpfile_stdout 17:32:01 INFO - Detecting whether we're running mozinstall >=1.0... 17:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:32:02 INFO - Reading from file tmpfile_stdout 17:32:02 INFO - Output received: 17:32:02 INFO - Usage: mozinstall [options] installer 17:32:02 INFO - Options: 17:32:02 INFO - -h, --help show this help message and exit 17:32:02 INFO - -d DEST, --destination=DEST 17:32:02 INFO - Directory to install application into. [default: 17:32:02 INFO - "/builds/slave/test"] 17:32:02 INFO - --app=APP Application being installed. [default: firefox] 17:32:02 INFO - mkdir: /builds/slave/test/build/application 17:32:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:32:17 INFO - Reading from file tmpfile_stdout 17:32:17 INFO - Output received: 17:32:17 INFO - /builds/slave/test/build/application/firefox/firefox 17:32:17 INFO - Running post-action listener: _resource_record_post_action 17:32:17 INFO - ##### 17:32:17 INFO - ##### Running run-tests step. 17:32:17 INFO - ##### 17:32:17 INFO - Running pre-action listener: _resource_record_pre_action 17:32:17 INFO - Running main action method: run_tests 17:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:32:17 INFO - Python 2.7.3 17:32:17 INFO - Return code: 0 17:32:17 INFO - grabbing minidump binary from tooltool 17:32:17 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')]} 17:32:17 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 0x1fe7410>, '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 0x1fe8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:32:17 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 17:32:17 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 17:32:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:32:17 INFO - Return code: 0 17:32:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:32:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:32:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:32:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:32:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:32:18 INFO - Return code: 0 17:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 17:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 17:32:18 INFO - Using env: {'DISPLAY': ':0', 17:32:18 INFO - 'HOME': '/home/cltbld', 17:32:18 INFO - 'LANG': 'en_US.UTF-8', 17:32:18 INFO - 'LANGUAGE': 'en_US:en', 17:32:18 INFO - 'LOGNAME': 'cltbld', 17:32:18 INFO - 'MAIL': '/var/mail/cltbld', 17:32:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:32:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:18 INFO - 'MOZ_NO_REMOTE': '1', 17:32:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:18 INFO - 'NO_EM_RESTART': '1', 17:32:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:18 INFO - 'PWD': '/builds/slave/test', 17:32:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:32:18 INFO - 'SHELL': '/bin/bash', 17:32:18 INFO - 'SHLVL': '1', 17:32:18 INFO - 'TERM': 'linux', 17:32:18 INFO - 'TMOUT': '86400', 17:32:18 INFO - 'USER': 'cltbld', 17:32:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334', 17:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:18 INFO - '_': '/tools/buildbot/bin/python'} 17:32:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 17:32:19 INFO - mozversion application_buildid: 20160414165245 17:32:19 INFO - mozversion application_changeset: e595db332894e0d6a2bacd793f792d56ce3960d1 17:32:19 INFO - mozversion application_display_name: Nightly 17:32:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:32:19 INFO - mozversion application_name: Firefox 17:32:19 INFO - mozversion application_remotingname: firefox 17:32:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:32:19 INFO - mozversion application_vendor: Mozilla 17:32:19 INFO - mozversion application_version: 48.0a1 17:32:19 INFO - mozversion platform_buildid: 20160414165245 17:32:19 INFO - mozversion platform_changeset: e595db332894e0d6a2bacd793f792d56ce3960d1 17:32:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:32:19 INFO - mozversion platform_version: 48.0a1 17:32:19 INFO - using testdate: 1460680339 17:32:19 INFO - actual date: 1460680339 17:32:19 INFO - starting webserver on 'localhost:36220' 17:32:19 INFO - SUITE-START | Running 2 tests 17:32:19 INFO - TEST-START | dromaeo_css 17:32:19 INFO - operating with platform_type : linux_ 17:32:19 INFO - Initialising browser for dromaeo_css test... 17:32:19 INFO - TEST-INFO | started process 22929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkG7YGi/profile http://localhost:36220/getInfo.html) 17:32:23 INFO - PROCESS | 22929 | __metrics Screen width/height:1600/1200 17:32:23 INFO - PROCESS | 22929 | colorDepth:24 17:32:23 INFO - PROCESS | 22929 | Browser inner width/height: 1024/697 17:32:23 INFO - PROCESS | 22929 | __metrics 17:32:24 ERROR - PROCESS | 22929 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:32:25 INFO - TEST-INFO | 22929: exit 0 17:32:25 INFO - Browser initialized. 17:32:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:32:25 INFO - TEST-INFO | started process 23010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkG7YGi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:37 INFO - PROCESS | 23010 | RSS: Main: 154763264 17:32:37 INFO - PROCESS | 23010 | 17:33:29 INFO - PROCESS | 23010 | 1460680409157 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] 17:35:40 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:36220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36220/tests/dromaeo/cssquery-ext.html) 17:35:41 INFO - PROCESS | 23010 | RSS: Main: 266039296 17:35:41 INFO - PROCESS | 23010 | 17:38:44 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:36220/tests/dromaeo/cssquery-ext.html (next: http://localhost:36220/tests/dromaeo/cssquery-jquery.html) 17:38:44 INFO - PROCESS | 23010 | RSS: Main: 231464960 17:38:44 INFO - PROCESS | 23010 | 17:41:47 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:36220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36220/tests/dromaeo/cssquery-mootools.html) 17:41:47 INFO - PROCESS | 23010 | RSS: Main: 233410560 17:41:47 INFO - PROCESS | 23010 | 17:44:49 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:36220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36220/tests/dromaeo/cssquery-prototype.html) 17:44:50 INFO - PROCESS | 23010 | RSS: Main: 230117376 17:44:50 INFO - PROCESS | 23010 | 17:47:53 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:36220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36220/tests/dromaeo/cssquery-yui.html) 17:47:53 INFO - PROCESS | 23010 | RSS: Main: 214614016 17:47:53 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | Cycle 1(1): loaded http://localhost:36220/tests/dromaeo/cssquery-yui.html (next: http://localhost:36220/tests/dromaeo/cssquery-dojo.html) 17:50:56 INFO - PROCESS | 23010 | RSS: Main: 262328320 17:50:56 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | __start_tp_report 17:50:56 INFO - PROCESS | 23010 | _x_x_mozilla_page_load 17:50:56 INFO - PROCESS | 23010 | _x_x_mozilla_page_load_details 17:50:56 INFO - PROCESS | 23010 | |i|pagename|runs| 17:50:56 INFO - PROCESS | 23010 | |0;dojo.html;2636.5781474964006;2711.349276173719;2711.7017128115917;2716.8098233123687;2743.0399360223923;4674.0651869626045;4706.976465117674;4711.411073615798;4741.288806679;4749.382580264565;4704.247320428732;4730.597899178574;4756.952430475694;4772.451168115667;4779.354787103749;4213.641840443551;4262.211490874182;4265.765382903939;4292.849750258742;4438.134563760068;4357.12857428514;4379.934300985487;4394.07724377881;4407.933880991788;4444.97777511112;4231.936520952188;4288.549702281278;4298.591633794785;4324.545922678105;4349.934750978738;4297;4304.182205380999;4309.987153019038;4313.482382114135;4350.782460876943;4278.700490965633;4295.763732994684;4296.5059018213;4325.091730736549;4339.088791353819;4488.281874900001;4497.730136191806;4552.863414097583;4557.567031132037;4625.7687115644085;4940.777665005047;5015.32293140425;5034;5035.791410061595;5041.218611115283;5047.192449208146;5055.494450554915;5060.418051924003;5064.139096353629;5084.669496482754;4665.790039448233;4700.882477938079;4735.100330937111;4778.832740854054;4780.641451891122;5140.126178549655;5151.407588127413;5155.32980712505;5157.484251574812;5162.793488260428;4844.297576851407;4951.108800415887;4951.306817045616;4953.702777833341;5005.424376196711;5018.372703412074;5027.2207807789855;5058.342415486037;5090.363704536933;5095.184770436712;4909.337239472626;4955.554000140005;4955.603551715854;4981.975090124526;5030.245463180552;4765.785539650655;4855.8057677693205;4907.263910413467;4920.458749537548;4960.107180707508;4173.144505376391;4303.569643035671;4315.093830295673;4315.3742707307265;4319.416878721395;3711.9814400928362;3714.4428335749312;3714.461403096536;3751.2872554214614;3760.9247815043545;4377.102693947733;4385.846495372647;4386.0789234261165;4388.9122217556105;4433.312836510346;4918.409790825124;5018.498150185025;5065.468125846806;5104.183330667075;5113.590912726973;4346.521882592912;4366.868993930188;4369.126174764996;4369.71596846204;4411.558844115562;4431.423914891108;4504.572065653758;4506.7295962241715;4511.075229577928;4558.270676691714;4755.857324280346;4783.6651434399255;4797.088553174885;4819.204831202812;4833.492483289204;5001.049800537886;5040.798368065236;5046.84859454217;5050.292958985671;5097.209932460474;4651.3023046543285;4768.880777980578;4778.737169455713;4789.616830653609;4820.421549414093;5009.3487846581165;5015.423226329019;5032.874178145576;5072.213806859942;5084.745762711924;5075.137226671549;5096.05722941257;5097.770600323069;5102.209157580581;5106.10643137442;4744.59670927975;4804.735739534359;4917.991811678526;4935.851924442272;4942.406911170682;4855.587275081658;4872.220444728827;4872.342233798392;4886.389201349832;4915.483874193158;4779.976100119477;4795.472498025284;4796.3285140079715;4802.759862006956;4837.927431088466;4664.510226426312;4866;4950;4952.504749525018;4960.801567937387;4789.425268967746;4808.591269742111;4810.518948105161;4837.854864354075;4847.491013443538 17:50:56 INFO - PROCESS | 23010 | |1;ext.html;561.2017252491199;579.9275090613673;592.8962431574473;602.7468463245435;611.3977731934046;26387.604185937227;34848.47727284089;35622.90336611291;35674.2865142697;35687.2862542749;37539.624603754026;38224.23551528968;38261.426078608776;38326.42510362347;38327.616723832754;7266.781996540112;7493.475456718032;7497.850042999136;7749.806254843632;7937.9680641516525;7321.450891183183;9808.705738827846;10196.847047294297;10212.540435680412;10221.182305415587;9903.752406189868;9994.600215991351;10004.549795259194;10005.899941000605;10010.799784004315;7438.995735575682;7769.72805951789;9802.509874506282;9910.90089099107;9924.80150396988;9766.90233097667;10222.795544089076;10229.744256393575;10231.232657550714;10236;35565.11087222814;36145.63854361449;36205.27589448223;36248.27503449943;36290.8185459071;2984.7462965647946;3000.1449586867857;3002.1293824790782;3026;3064.5862808520787;27488.17535473939;27638.723612763817;28061;29776.8511157445;30250.54624180639;3489.197484578561;3490.371733088043;3510.473428985647;3557.217412169319;3639.0720366306687;167704;167948;168695;223923;224637;54601.180982285296;55499.722501388045;55697.721511392185;55734.09861309751;55740.442595574335;59277.701121842976;61013;61145.694271529246;61162.69418652878;61206.38793612096;12749.42627581761;12784.232946023269;12800.743985120245;12802.295873726847;12812.487500499876;10219.7445063874;10653.467326633638;11049.723756905982;11548.826767598493;11635.53457861693;17989.280428782702;18026.3690770825;18039.54901127456;18092.019755653735;18165.81834181641;6673.9332606673315;6736.730530778812;6783.93216067833;6809.897851532231;6857.5199736018;898.5327629632685;929.2705226397246;939.4551160326994;991.6925753016588;1005.2249824756819;28561;28962.42075158485;29140.708592914223;29209.707902921124;29541.556876646868;967.4920666649924;974.5711886769799;1001.5643195210107;1005.7485628592851;1034.7649077991503;15394.692106157814;15522.37910483568;15558.844411555965;15567.766483502757;15909.602259943362;333481;334192;335178;339874;340031;49301.26048109281;50336.24495632568;50597.747011264706;50671.23993140106;50765;1054.314695447965;1148.1388958281289;1258.9685257868628;1276;1278.1117123599195;26624.866875666274;28051.43897122087;28382.71617283801;28526.85736571304;28947.56578651364;39214;39301.2139757209;39493.2101357977;39514.802425987684;39656.80171599239;217898;219369;219881;220405;220552;22878.65682014738;25298.36754081089;25932;25933.481330373663;25998;39120.21759564849;40039.39940900831;40189.397159042055;40640.79679601583;41028.384574232005;33783.01746008078;33956.3208735819;34756.82621586876;34764.82617586896;34881.65118348784;34500.30999380049;34510.13724656803;34753.82623086868;34904;35144.64855351414;34194;34625;34799.13002174966;34891;34904.47643285403;31988.68011319857;33721.3255734879;33818.66181338155;34469.655303447646;34479.827600861834;23433.765662343158;23456.882715586315;23484.412889677893;23814.404639884142;23889.28332150038 17:50:56 INFO - PROCESS | 23010 | |2;jquery.html;381.67938931297715;387.9844806207752;393.4236343756396;404.97975101244947;405.7180259719496;15628.687426251468;16335.979165939105;16484.587885302873;16505.66988660226;16523.50429487116;15541.378344866192;16473.258703358348;17056.23246953887;17195.82804171958;17324.566885827862;4774.474807771142;4935.605151587864;4951.653384263103;4953.603711703073;4964.329815474901;3486.3201675673254;5248.448912864152;5541.833744987636;5560.138178582326;5566.86082847928;5281.445448227938;5532.3637781655025;5534.806281780138;5550.944490555104;5553.555715542767;6102.115193296947;6124.816255512342;6125.295591007024;6130.080487926824;6148.938510614904;3392.3384939936723;3578.982105089484;3590.0665826885197;3591.9281614367565;5058.367704036996;12258.877411225863;12342.691432714164;12359.938200308941;13053;20067.1973121075;1913.7512123424005;1921;1922.5866438715602;1945.2121890634317;2071.4510654676524;8689.826203475895;9383.24934005278;9567.521623918847;9649.662261820802;9753.366031207948;1779.9288028478845;1797.2451570340488;1845.6493266279365;1846.5014446099478;1899.563100486882;42916.78541607272;54083;71334.64332678355;71401.64299178471;72130.27869721288;10095.44475053879;10247.795044099077;10282.177425806067;10324.277300588887;10482.580696772196;14428.278586070865;14479.276036198147;14479.565613031626;14482.565523034325;14502;7070.9914502051715;7270.139650724956;7323.084614423197;7360.521566098187;7406.777796666109;6736.5284430090405;6764.72941082361;6774.45804335652;6796.966015169893;6907.171139463297;4434.800433980478;4463.977680111643;4502;4515.07440974606;4581.198290299184;1705.4372057221087;2870.4833130036377;3077.938441231163;3099.838165071659;3380.1042723678247;879.2218886285556;882.3867412148495;895.3106108296575;908.2597682888425;936.4942930817418;15903.363865445253;16121.677566448605;17097.914510427618;17256.482305530855;18317.17572709231;875.5578432891476;887.4719541872704;890.7862113092812;896.7130518234233;945.2438049560325;9409.670661526814;9691.51542422876;9716.271279654055;9778.364406313567;9831.557579908922;394273;402390;408450;410972;413213;75436.62281688556;81110.59444702738;82827.58586207152;83756;84621;964.8022155458115;970.427447805798;999.8250306196387;1002.0880998291519;1004.3271008424373;15273.312700928707;15449.613759656098;15579.922100389425;15605;15943.521694349189;32695.836520817244;33852.49221261634;35036.824815875756;35199.47200791939;35540.466892997145;43829.90425239394;45466;47113;48715.269270961675;48802.02395952132;7352.37504812097;7466.887996679946;7535.886961695689;7697.653605587874;7792.766217013499;10838.67483975482;11148.442577871236;11626.88373116258;11634.243774154653;11929;9971.750706232402;10083.697489075339;10311;10381.338985762544;10394.688159355232;9652.469114198786;9942.652007179713;10240.283180177614;10301.381917084998;10651.147908167173;10165.390076595428;10469.842952355873;10557.683269501927;10663.253572249869;10679.09227715653;7503;7575.393968482618;7591.240875912365;7681.923180768121;7783.571903545359;10362.896371036193;10420.68737937863;10422.895771042193;10468.738281543023;10513.632022879163 17:50:56 INFO - PROCESS | 23010 | |3;mootools.html;1271.9491220351185;1450.028480917785;1476.527511196417;1639.8770092243085;1789.454216463978;7338.412926965843;7662.233776622335;7677.769666909988;7679.769606911787;7680.270374314438;7461.40308775298;7568.545887246769;7572.318491335793;7602.885956710654;7604.125525564548;1919.8752081114753;2181.301983365324;2194.1991173221777;2227.565624703175;2258.627326491127;2243.6522339037474;2262.253456359406;2265.852719573231;2268.7617800130915;2269.251147121446;2174.8038578781684;2231.163313757341;2237.1498830444407;2239.9552008959813;2242.237639202671;1906.5614908571038;2128.2976617716195;2202.8237740980685;2208.569328980849;2209.2267706302828;2130.7762684918016;2140.1332460353583;2150.849440539163;2152.257471172443;2198.2855571939185;7605.391568674493;7633.732819351296;7690.461667683265;7695.538267703956;7703.499272547267;4516.36770852081;4656.068786242765;4657.464391594942;4671.556202160789;4674.6209868089;2943.2200466876293;2945.0428610701606;3020.0486846643457;3020.1241639924397;3056.3581647853975;990.6730778842965;1017.8931212222758;1041.1358572384902;1042.6038105519854;1055.8469021991846;10440.895591044069;10479.214058945534;10501.317414367964;10516.684499464951;10537.525811338508;4092.529359123679;4355.1507456045765;4357.67317451186;4367.781610919441;4386;8903.821923561492;9043.547822608843;9047.77380565478;9078.636854525745;9105.77235569116;4170.812313445902;4704.482506924304;4713.387259656222;4723.6929599575915;4730.361401210861;4206.432131662247;4291.742495450283;4298.4197133387215;4325.891852703708;4329.415528903558;3577.8926632201074;3674;3735.1595890924323;3745.7752534847996;3788.5264341957254;1231.655136561764;1244.5333000124954;1254.9058820588493;1264.607971528829;1271.8092286156966;822.387321445515;844.2359664503634;854.256796586961;883.5228976352697;888.1695614600369;5230.607704422184;5311.681299122065;5327.067763141435;5346.224797404355;5375.677459352373;422.5900876150129;431.6201742466672;438.9912201755947;439.6658539509995;441.24326779573187;3721.2557488502407;3731.029932217643;3767.1147280389087;3802.980985095057;3809.7904615245875;9210.539473026322;9568;9687.51562421876;9697.127258546765;9700.078492543196;9564.76088097803;9573.617055317849;9581.425114493153;9585.760355991017;9591.280653950982;7142.92857071433;7246.818829529304;7253.455990800711;7326.3040011198855;7344.889826652605;5371.140617501181;5394.67830381559;5400.702961337164;5414.29614150158;5422.539084177889;8607.48355098696;8673.522956237215;8676.869846952175;8718.520481373585;8786.604602793017;8497.702580409656;8763.474191548528;8948.552572371225;8948.821023579621;8980.595873185592;5811.476967072984;5856.94143058581;6333.20834895638;6666.100076489612;6858.588484690935;7331.74338898136;7435.4795164337975;7457.77626671179;7462.104547454123;7474.439417043852;6751.662416879039;6842.486813488908;6856.4514838813775;6918.238993710587;6919.688614012281;6595.208574971034;6618.205815302194;6620.966895165493;6744.494162937701;6795.38841504267;6306.936930630818;6405.647689377129;6426.4216220540375;6441.71012304438;6464.09502669636;4542.6365890728;4631.745254011062;4742.976285118552;4760.880977975578;4772.570468657698;4783.258594917794;4856.95143048565;4893.730844803427;4944.381952255968;4950.653454258311 17:50:56 INFO - PROCESS | 23010 | |4;prototype.html;314.86775554267217;321.43427567481234;325.80126123064935;326.4368963537896;329.9785513941595;5104.617153713472;5179.3007943927605;5188.16989281715;5199.948000519994;5226.372835259769;5101.234814777785;5106.285120083191;5112.667676601028;5123.871903202422;5127.512886275807;3804.771713697187;3884.4173373993845;4040.1919616076757;4048.554658987509;4057.5942405759333;4016.8995775105564;4021.195760847842;4049.9392509112386;4052.128792309653;4061.3501839705655;3794.867179648699;4000.3199456092534;4012.1975604878994;4012.739171953828;4029.5970402959615;3876.2247550489874;4002.3596224603925;4019.839206431739;4020.8190631421658;4024.637782599551;3559.48387483816;3561.857525698969;3569.6965757910607;3569.7322700797286;3570.732195085379;4915.239841521239;4928;4930.619426560533;4936.593070974755;4965.329680493123;4531.501534831166;4566.908661826745;4627.838025669085;4640.744759038252;4649.744264065475;5329.706866122362;5359.973200133974;5366.168243922199;5368.242230438669;5372.301600791911;3909.765414075136;3913.7064720146104;3916.667083297923;3927.998360418104;3934.9213015739524;5498.99999999996;5609.5792815539;5627.296587926509;5635.436456354373;5640.802571910004;3989.082511022481;4012.3981402789814;4014.5182578090817;4022.8276730565167;4031;4046.7774272414713;4064.4919385076864;4068.6541643960004;4113.621936651196;4115.6295933365545;4511.481179664315;4547.636189104864;4628.95371046292;4637.652176086807;4642;5407;5411.188321751769;5426.538744206787;5427.6200665953;5429.511343979061;1413.9363728632236;1427.664498842771;1436.590571687064;1437.6980834024762;1440.625437386287;917.8022680402006;958.1472489484364;961.2550273537925;970.839811431106;986.1223511075149;4747.264174053027;4752.714837109785;4787.138315103245;4788.928166077511;4798.592119669797;5553;5555.666660000413;5556.111022236503;5560.638558493685;5565.080047383646;4673.556012178838;4715.834945776881;4763.45220299663;4779.115863565252;4783.354247176587;2947.882084716587;2958.5266357382716;2966.6440027196873;2974.836383998901;2976.7320941115404;5134.845954621367;5166.896662066738;5175.171972484384;5191.480851914778;5219.138842091088;5459.235707001023;5632.831015069554;5655.123455864347;5681.857953551194;5688.544916406678;5206.8958620828125;5220.712860792617;5226.869328266824;5228.215767634885;5234.581233501311;5419.376771671308;5523.8066667666435;5540.556755459473;5545.140503222007;5559.19391688211;5368.2484452177505;5451.509364157245;5460.481254280837;5462.9180562292395;5465.316835395575;5192.0924282401975;5220.347456567929;5229.424763276113;5232.476752324889;5233.528982391603;3945.5659877412886;4001.899477643671;4048.0689441429226;4051.756894586334;4056.513218413809;5500.669959802424;5505.311836020497;5505.339359276913;5522.834314970557;5526.281583394133;5246.921296180637;5297.17893726473;5302.893942121059;5312.840614781563;5326.508577598279;5146.665466744649;5294.947050529446;5310.920336194883;5315.734213289397;5320.654157479751;5060.987802439453;5188.948110518997;5248.343957005374;5251.26482292487;5262.921056184084;5208.317716375994;5467.753951072132;5470.589705772003;5474.753636086306;5475.4524547544925;5324.653897496651;5329.09405401075;5334.733263336895;5338.733063346895;5338.839834804962 17:50:56 INFO - PROCESS | 23010 | |5;yui.html;722.804842692473;760.3081196111536;771.756896577578;779.1857508903196;782.7221336425565;12086.274823510585;12623.936880315585;12684.556040538582;12692.746145077093;12706;13250.403731832066;13293.069485136044;13315.733685326288;13362.799558006613;13364.264965426897;648.6237981970446;803.871380579109;818.4189225649795;818.8648872935988;819.1112642782558;780.9375249980017;804.5534728225832;804.6580203413555;807.4267270238138;809.7570728781371;849.2484151525882;850.2517784349764;854.0520022774715;854.1885209051395;854.1927878155146;669.5045666206972;824.9010118785724;845.7547311279721;847.4618617178105;848.707196017373;618.4588485075559;619.0868469008221;619.7118339971889;621.8973869311558;623.965681887496;11974.521019159223;11980.161388702794;11981.880181198163;12048.036157107497;12056.698582535419;11995.700107497383;12507.187032842836;12582.68543286416;12741.872581274161;12812.61562153137;10070.194384449227;10106.39361638304;10190.337628054152;10301.330413523172;10305.227107966857;3261.8858339958224;3287.112479630486;3309.652486488908;3360.2775403288165;3373.3927892979254;50913.49086509162;51214.74392628013;51307.486925130645;51815;52225.216621750704;9723.270754693285;9799.902000980042;9858.556364963593;9918.30571859963;9959.800803984024;16763.078030708184;16827.579310517336;16853.915730421268;16896.831031689526;16909.830901690824;6168.568200226031;6388.105665206875;6560.8359791005605;6682.431993280626;6769.72921083161;3698.14942563212;3755.3803622401997;3758.229562939591;3771.2080463102507;3798.1454172810895;2845.9715402845704;2944.748481895186;2958.304798372381;2959.245392424918;2960.4523163214876;517.1338008835186;522.4227228912074;525.8562626287809;527.5146864884316;530.2629345210161;614.4270667092259;626.2172284644195;629.2197674883204;634.9015902535115;635.7488791927162;7260.310270524292;7461.626918654046;7527.774166775005;7555.13115991657;7920.683172673029;519.8466452396552;614.2168734862996;619.9008158694587;621.5183232994466;633.5343522510951;3660.213054193361;3751.9869635198343;3817.3701339279264;3861.4400911867624;3865.1496670732395;56053.719731401085;58789;58831.70584147052;58905.11642325368;59061.70469147713;49288.50711492911;50590.24114638283;50707.43633073041;51322.23016654753;51512;46370;46478;46492.302615460794;46660.06679866451;47371.76314118476;7136.750213742494;7228.241034691492;7291.963540182265;7425.925740742523;7463.290987356192;29989.400211995202;30830.229244269074;30934.845325773225;30957.380852382375;31194.844025779727;39739.40390894197;40468;41279;41975.7901210492;42079.57920420756;8858.512781797062;9166.633334666538;10417.801952775528;10460.163186944874;10555.419451930218;11444.656660300205;11602.589641434262;11670.824937626112;11705.824412633987;11954.641360759191;8085;10804.567817287221;10944.835827462754;10973.615923442641;11099.5560177592;10540.947295263475;10634.680959571226;10740.516676749408;11001.119910407308;11006.119510438986;9468.621255149717;9667.806643867223;9773.218142548722;9819.705408837746;9911.65309214174;9052.275817934418;9290.16388525036;9376.015518370747;9377.812443751223;9404.435733855991;8971.461712297283;9120.726378208665;9154.267658587163;9155.816883662157;9290.62837486493 17:50:56 INFO - PROCESS | 23010 | __end_tp_report 17:50:56 INFO - PROCESS | 23010 | __start_cc_report 17:50:56 INFO - PROCESS | 23010 | _x_x_mozilla_cycle_collect,1111 17:50:56 INFO - PROCESS | 23010 | __end_cc_report 17:50:56 INFO - PROCESS | 23010 | __startTimestamp1460681456665__endTimestamp 17:50:56 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | ------- Summary: start ------- 17:50:56 INFO - PROCESS | 23010 | Number of tests: 6 17:50:56 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | [#0] dojo.html Cycles:165 Average:4650.27 Median:4780.64 stddev:476.16 (10.0%) stddev-sans-first:450.66 17:50:56 INFO - PROCESS | 23010 | Values: 2636.6 2711.3 2711.7 2716.8 2743.0 4674.1 4707.0 4711.4 4741.3 4749.4 4704.2 4730.6 4757.0 4772.5 4779.4 4213.6 4262.2 4265.8 4292.8 4438.1 4357.1 4379.9 4394.1 4407.9 4445.0 4231.9 4288.5 4298.6 4324.5 4349.9 4297.0 4304.2 4310.0 4313.5 4350.8 4278.7 4295.8 4296.5 4325.1 4339.1 4488.3 4497.7 4552.9 4557.6 4625.8 4940.8 5015.3 5034.0 5035.8 5041.2 5047.2 5055.5 5060.4 5064.1 5084.7 4665.8 4700.9 4735.1 4778.8 4780.6 5140.1 5151.4 5155.3 5157.5 5162.8 4844.3 4951.1 4951.3 4953.7 5005.4 5018.4 5027.2 5058.3 5090.4 5095.2 4909.3 4955.6 4955.6 4982.0 5030.2 4765.8 4855.8 4907.3 4920.5 4960.1 4173.1 4303.6 4315.1 4315.4 4319.4 3712.0 3714.4 3714.5 3751.3 3760.9 4377.1 4385.8 4386.1 4388.9 4433.3 4918.4 5018.5 5065.5 5104.2 5113.6 4346.5 4366.9 4369.1 4369.7 4411.6 4431.4 4504.6 4506.7 4511.1 4558.3 4755.9 4783.7 4797.1 4819.2 4833.5 5001.0 5040.8 5046.8 5050.3 5097.2 4651.3 4768.9 4778.7 4789.6 4820.4 5009.3 5015.4 5032.9 5072.2 5084.7 5075.1 5096.1 5097.8 5102.2 5106.1 4744.6 4804.7 4918.0 4935.9 4942.4 4855.6 4872.2 4872.3 4886.4 4915.5 4780.0 4795.5 4796.3 4802.8 4837.9 4664.5 4866.0 4950.0 4952.5 4960.8 4789.4 4808.6 4810.5 4837.9 4847.5 17:50:56 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | [#1] ext.html Cycles:180 Average:41494.57 Median:34331.83 stddev:67419.52 (196.4%) stddev-sans-first:67538.59 17:50:56 INFO - PROCESS | 23010 | Values: 561.2 579.9 592.9 602.7 611.4 26387.6 34848.5 35622.9 35674.3 35687.3 37539.6 38224.2 38261.4 38326.4 38327.6 7266.8 7493.5 7497.9 7749.8 7938.0 7321.5 9808.7 10196.8 10212.5 10221.2 9903.8 9994.6 10004.5 10005.9 10010.8 7439.0 7769.7 9802.5 9910.9 9924.8 9766.9 10222.8 10229.7 10231.2 10236.0 35565.1 36145.6 36205.3 36248.3 36290.8 2984.7 3000.1 3002.1 3026.0 3064.6 27488.2 27638.7 28061.0 29776.9 30250.5 3489.2 3490.4 3510.5 3557.2 3639.1 167704.0 167948.0 168695.0 223923.0 224637.0 54601.2 55499.7 55697.7 55734.1 55740.4 59277.7 61013.0 61145.7 61162.7 61206.4 12749.4 12784.2 12800.7 12802.3 12812.5 10219.7 10653.5 11049.7 11548.8 11635.5 17989.3 18026.4 18039.5 18092.0 18165.8 6673.9 6736.7 6783.9 6809.9 6857.5 898.5 929.3 939.5 991.7 1005.2 28561.0 28962.4 29140.7 29209.7 29541.6 967.5 974.6 1001.6 1005.7 1034.8 15394.7 15522.4 15558.8 15567.8 15909.6 333481.0 334192.0 335178.0 339874.0 340031.0 49301.3 50336.2 50597.7 50671.2 50765.0 1054.3 1148.1 1259.0 1276.0 1278.1 26624.9 28051.4 28382.7 28526.9 28947.6 39214.0 39301.2 39493.2 39514.8 39656.8 217898.0 219369.0 219881.0 220405.0 220552.0 22878.7 25298.4 25932.0 25933.5 25998.0 39120.2 40039.4 40189.4 40640.8 41028.4 33783.0 33956.3 34756.8 34764.8 34881.7 34500.3 34510.1 34753.8 34904.0 35144.6 34194.0 34625.0 34799.1 34891.0 34904.5 31988.7 33721.3 33818.7 34469.7 34479.8 23433.8 23456.9 23484.4 23814.4 23889.3 17:50:56 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | [#2] jquery.html Cycles:180 Average:24339.62 Median:204427.86 stddev:66902.72 (32.7%) stddev-sans-first:67066.22 17:50:56 INFO - PROCESS | 23010 | Values: 381.7 388.0 393.4 405.0 405.7 15628.7 16336.0 16484.6 16505.7 16523.5 15541.4 16473.3 17056.2 17195.8 17324.6 4774.5 4935.6 4951.7 4953.6 4964.3 3486.3 5248.4 5541.8 5560.1 5566.9 5281.4 5532.4 5534.8 5550.9 5553.6 6102.1 6124.8 6125.3 6130.1 6148.9 3392.3 3579.0 3590.1 3591.9 5058.4 12258.9 12342.7 12359.9 13053.0 20067.2 1913.8 1921.0 1922.6 1945.2 2071.5 8689.8 9383.2 9567.5 9649.7 9753.4 1779.9 1797.2 1845.6 1846.5 1899.6 42916.8 54083.0 71334.6 71401.6 72130.3 10095.4 10247.8 10282.2 10324.3 10482.6 14428.3 14479.3 14479.6 14482.6 14502.0 7071.0 7270.1 7323.1 7360.5 7406.8 6736.5 6764.7 6774.5 6797.0 6907.2 4434.8 4464.0 4502.0 4515.1 4581.2 1705.4 2870.5 3077.9 3099.8 3380.1 879.2 882.4 895.3 908.3 936.5 15903.4 16121.7 17097.9 17256.5 18317.2 875.6 887.5 890.8 896.7 945.2 9409.7 9691.5 9716.3 9778.4 9831.6 394273.0 402390.0 408450.0 410972.0 413213.0 75436.6 81110.6 82827.6 83756.0 84621.0 964.8 970.4 999.8 1002.1 1004.3 15273.3 15449.6 15579.9 15605.0 15943.5 32695.8 33852.5 35036.8 35199.5 35540.5 43829.9 45466.0 47113.0 48715.3 48802.0 7352.4 7466.9 7535.9 7697.7 7792.8 10838.7 11148.4 11626.9 11634.2 11929.0 9971.8 10083.7 10311.0 10381.3 10394.7 9652.5 9942.7 10240.3 10301.4 10651.1 10165.4 10469.8 10557.7 10663.3 10679.1 7503.0 7575.4 7591.2 7681.9 7783.6 10362.9 10420.7 10422.9 10468.7 10513.6 17:50:56 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | [#3] mootools.html Cycles:180 Average:5128.34 Median:4875.34 stddev:2827.84 (58.0%) stddev-sans-first:2820.92 17:50:56 INFO - PROCESS | 23010 | Values: 1271.9 1450.0 1476.5 1639.9 1789.5 7338.4 7662.2 7677.8 7679.8 7680.3 7461.4 7568.5 7572.3 7602.9 7604.1 1919.9 2181.3 2194.2 2227.6 2258.6 2243.7 2262.3 2265.9 2268.8 2269.3 2174.8 2231.2 2237.1 2240.0 2242.2 1906.6 2128.3 2202.8 2208.6 2209.2 2130.8 2140.1 2150.8 2152.3 2198.3 7605.4 7633.7 7690.5 7695.5 7703.5 4516.4 4656.1 4657.5 4671.6 4674.6 2943.2 2945.0 3020.0 3020.1 3056.4 990.7 1017.9 1041.1 1042.6 1055.8 10440.9 10479.2 10501.3 10516.7 10537.5 4092.5 4355.2 4357.7 4367.8 4386.0 8903.8 9043.5 9047.8 9078.6 9105.8 4170.8 4704.5 4713.4 4723.7 4730.4 4206.4 4291.7 4298.4 4325.9 4329.4 3577.9 3674.0 3735.2 3745.8 3788.5 1231.7 1244.5 1254.9 1264.6 1271.8 822.4 844.2 854.3 883.5 888.2 5230.6 5311.7 5327.1 5346.2 5375.7 422.6 431.6 439.0 439.7 441.2 3721.3 3731.0 3767.1 3803.0 3809.8 9210.5 9568.0 9687.5 9697.1 9700.1 9564.8 9573.6 9581.4 9585.8 9591.3 7142.9 7246.8 7253.5 7326.3 7344.9 5371.1 5394.7 5400.7 5414.3 5422.5 8607.5 8673.5 8676.9 8718.5 8786.6 8497.7 8763.5 8948.6 8948.8 8980.6 5811.5 5856.9 6333.2 6666.1 6858.6 7331.7 7435.5 7457.8 7462.1 7474.4 6751.7 6842.5 6856.5 6918.2 6919.7 6595.2 6618.2 6621.0 6744.5 6795.4 6306.9 6405.6 6426.4 6441.7 6464.1 4542.6 4631.7 4743.0 4760.9 4772.6 4783.3 4857.0 4893.7 4944.4 4950.7 17:50:56 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | [#4] prototype.html Cycles:180 Average:4482.78 Median:5125.69 stddev:1281.48 (25.0%) stddev-sans-first:1246.31 17:50:56 INFO - PROCESS | 23010 | Values: 314.9 321.4 325.8 326.4 330.0 5104.6 5179.3 5188.2 5199.9 5226.4 5101.2 5106.3 5112.7 5123.9 5127.5 3804.8 3884.4 4040.2 4048.6 4057.6 4016.9 4021.2 4049.9 4052.1 4061.4 3794.9 4000.3 4012.2 4012.7 4029.6 3876.2 4002.4 4019.8 4020.8 4024.6 3559.5 3561.9 3569.7 3569.7 3570.7 4915.2 4928.0 4930.6 4936.6 4965.3 4531.5 4566.9 4627.8 4640.7 4649.7 5329.7 5360.0 5366.2 5368.2 5372.3 3909.8 3913.7 3916.7 3928.0 3934.9 5499.0 5609.6 5627.3 5635.4 5640.8 3989.1 4012.4 4014.5 4022.8 4031.0 4046.8 4064.5 4068.7 4113.6 4115.6 4511.5 4547.6 4629.0 4637.7 4642.0 5407.0 5411.2 5426.5 5427.6 5429.5 1413.9 1427.7 1436.6 1437.7 1440.6 917.8 958.1 961.3 970.8 986.1 4747.3 4752.7 4787.1 4788.9 4798.6 5553.0 5555.7 5556.1 5560.6 5565.1 4673.6 4715.8 4763.5 4779.1 4783.4 2947.9 2958.5 2966.6 2974.8 2976.7 5134.8 5166.9 5175.2 5191.5 5219.1 5459.2 5632.8 5655.1 5681.9 5688.5 5206.9 5220.7 5226.9 5228.2 5234.6 5419.4 5523.8 5540.6 5545.1 5559.2 5368.2 5451.5 5460.5 5462.9 5465.3 5192.1 5220.3 5229.4 5232.5 5233.5 3945.6 4001.9 4048.1 4051.8 4056.5 5500.7 5505.3 5505.3 5522.8 5526.3 5246.9 5297.2 5302.9 5312.8 5326.5 5146.7 5294.9 5310.9 5315.7 5320.7 5061.0 5188.9 5248.3 5251.3 5262.9 5208.3 5467.8 5470.6 5474.8 5475.5 5324.7 5329.1 5334.7 5338.7 5338.8 17:50:56 INFO - PROCESS | 23010 | 17:50:56 INFO - PROCESS | 23010 | [#5] yui.html Cycles:180 Average:13300.85 Median:26166.07 stddev:15965.13 (61.0%) stddev-sans-first:15981.98 17:50:56 INFO - PROCESS | 23010 | Values: 722.8 760.3 771.8 779.2 782.7 12086.3 12623.9 12684.6 12692.7 12706.0 13250.4 13293.1 13315.7 13362.8 13364.3 648.6 803.9 818.4 818.9 819.1 780.9 804.6 804.7 807.4 809.8 849.2 850.3 854.1 854.2 854.2 669.5 824.9 845.8 847.5 848.7 618.5 619.1 619.7 621.9 624.0 11974.5 11980.2 11981.9 12048.0 12056.7 11995.7 12507.2 12582.7 12741.9 12812.6 10070.2 10106.4 10190.3 10301.3 10305.2 3261.9 3287.1 3309.7 3360.3 3373.4 50913.5 51214.7 51307.5 51815.0 52225.2 9723.3 9799.9 9858.6 9918.3 9959.8 16763.1 16827.6 16853.9 16896.8 16909.8 6168.6 6388.1 6560.8 6682.4 6769.7 3698.1 3755.4 3758.2 3771.2 3798.1 2846.0 2944.7 2958.3 2959.2 2960.5 517.1 522.4 525.9 527.5 530.3 614.4 626.2 629.2 634.9 635.7 7260.3 7461.6 7527.8 7555.1 7920.7 519.8 614.2 619.9 621.5 633.5 3660.2 3752.0 3817.4 3861.4 3865.1 56053.7 58789.0 58831.7 58905.1 59061.7 49288.5 50590.2 50707.4 51322.2 51512.0 46370.0 46478.0 46492.3 46660.1 47371.8 7136.8 7228.2 7292.0 7425.9 7463.3 29989.4 30830.2 30934.8 30957.4 31194.8 39739.4 40468.0 41279.0 41975.8 42079.6 8858.5 9166.6 10417.8 10460.2 10555.4 11444.7 11602.6 11670.8 11705.8 11954.6 8085.0 10804.6 10944.8 10973.6 11099.6 10540.9 10634.7 10740.5 11001.1 11006.1 9468.6 9667.8 9773.2 9819.7 9911.7 9052.3 9290.2 9376.0 9377.8 9404.4 8971.5 9120.7 9154.3 9155.8 9290.6 17:50:56 INFO - PROCESS | 23010 | -------- Summary: end -------- 17:50:56 INFO - PROCESS | 23010 | 17:50:57 INFO - TEST-INFO | 23010: exit 0 17:50:57 INFO - TEST-OK | dromaeo_css | took 1118347ms 17:50:57 INFO - TEST-START | kraken 17:50:57 INFO - operating with platform_type : linux_ 17:50:57 INFO - Initialising browser for kraken test... 17:50:57 INFO - TEST-INFO | started process 23187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkI_lB0/profile http://localhost:36220/getInfo.html) 17:51:01 INFO - PROCESS | 23187 | __metrics Screen width/height:1600/1200 17:51:01 INFO - PROCESS | 23187 | colorDepth:24 17:51:01 INFO - PROCESS | 23187 | Browser inner width/height: 1024/697 17:51:01 INFO - PROCESS | 23187 | __metrics 17:51:02 ERROR - PROCESS | 23187 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:51:03 INFO - TEST-INFO | 23187: exit 0 17:51:03 INFO - Browser initialized. 17:51:03 INFO - Running cycle 1/1 for kraken test... 17:51:03 INFO - TEST-INFO | started process 23267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkI_lB0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:15 INFO - PROCESS | 23267 | RSS: Main: 154550272 17:51:15 INFO - PROCESS | 23267 | 17:51:18 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36220/tests/kraken/driver.html?testName=audio-beat-detection) 17:51:19 INFO - PROCESS | 23267 | RSS: Main: 209084416 17:51:19 INFO - PROCESS | 23267 | 17:51:21 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36220/tests/kraken/driver.html?testName=audio-dft) 17:51:22 INFO - PROCESS | 23267 | RSS: Main: 195272704 17:51:22 INFO - PROCESS | 23267 | 17:51:25 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36220/tests/kraken/driver.html?testName=audio-fft) 17:51:26 INFO - PROCESS | 23267 | RSS: Main: 266203136 17:51:26 INFO - PROCESS | 23267 | 17:51:28 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36220/tests/kraken/driver.html?testName=audio-oscillator) 17:51:28 INFO - PROCESS | 23267 | RSS: Main: 173924352 17:51:28 INFO - PROCESS | 23267 | 17:51:31 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:51:31 INFO - PROCESS | 23267 | RSS: Main: 178499584 17:51:31 INFO - PROCESS | 23267 | 17:51:34 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36220/tests/kraken/driver.html?testName=imaging-darkroom) 17:51:35 INFO - PROCESS | 23267 | RSS: Main: 214495232 17:51:35 INFO - PROCESS | 23267 | 17:51:38 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36220/tests/kraken/driver.html?testName=imaging-desaturate) 17:51:39 INFO - PROCESS | 23267 | RSS: Main: 215052288 17:51:39 INFO - PROCESS | 23267 | 17:51:42 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36220/tests/kraken/driver.html?testName=json-parse-financial) 17:51:43 INFO - PROCESS | 23267 | RSS: Main: 215068672 17:51:43 INFO - PROCESS | 23267 | 17:51:44 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:51:45 INFO - PROCESS | 23267 | RSS: Main: 201854976 17:51:45 INFO - PROCESS | 23267 | 17:51:47 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36220/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:51:47 INFO - PROCESS | 23267 | RSS: Main: 206589952 17:51:47 INFO - PROCESS | 23267 | 17:51:49 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:51:50 INFO - PROCESS | 23267 | RSS: Main: 218173440 17:51:50 INFO - PROCESS | 23267 | 17:51:53 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:51:54 INFO - PROCESS | 23267 | RSS: Main: 224452608 17:51:54 INFO - PROCESS | 23267 | 17:51:57 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:51:57 INFO - PROCESS | 23267 | RSS: Main: 219934720 17:51:57 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | Cycle 1(1): loaded http://localhost:36220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36220/tests/kraken/driver.html?testName=ai-astar) 17:51:59 INFO - PROCESS | 23267 | RSS: Main: 282275840 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | __start_tp_report 17:51:59 INFO - PROCESS | 23267 | _x_x_mozilla_page_load 17:51:59 INFO - PROCESS | 23267 | _x_x_mozilla_page_load_details 17:51:59 INFO - PROCESS | 23267 | |i|pagename|runs| 17:51:59 INFO - PROCESS | 23267 | |0;ai-astar;113;115;106;112;112;113;101;111;112;111 17:51:59 INFO - PROCESS | 23267 | |1;audio-beat-detection;156;133;154;182;134;153;165;136;188;131 17:51:59 INFO - PROCESS | 23267 | |2;audio-dft;163;162;162;161;162;161;161;162;162;161 17:51:59 INFO - PROCESS | 23267 | |3;audio-fft;79;74;107;114;77;75;74;113;101;76 17:51:59 INFO - PROCESS | 23267 | |4;audio-oscillator;95;94;138;95;94;93;148;94;95;137 17:51:59 INFO - PROCESS | 23267 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;117 17:51:59 INFO - PROCESS | 23267 | |6;imaging-darkroom;148;149;151;148;150;147;150;149;149;146 17:51:59 INFO - PROCESS | 23267 | |7;imaging-desaturate;96;96;96;96;95;96;96;96;96;96 17:51:59 INFO - PROCESS | 23267 | |8;json-parse-financial;65;66;67;66;66;66;65;82;64;62 17:51:59 INFO - PROCESS | 23267 | |9;json-stringify-tinderbox;65;66;64;65;65;64;65;65;65;65 17:51:59 INFO - PROCESS | 23267 | |10;stanford-crypto-aes;84;84;83;82;85;85;92;85;86;84 17:51:59 INFO - PROCESS | 23267 | |11;stanford-crypto-ccm;139;146;137;135;136;136;144;146;171;138 17:51:59 INFO - PROCESS | 23267 | |12;stanford-crypto-pbkdf2;171;171;170;172;175;173;174;179;171;168 17:51:59 INFO - PROCESS | 23267 | |13;stanford-crypto-sha256-iterative;73;77;73;73;73;72;71;71;71;72 17:51:59 INFO - PROCESS | 23267 | __end_tp_report 17:51:59 INFO - PROCESS | 23267 | __start_cc_report 17:51:59 INFO - PROCESS | 23267 | _x_x_mozilla_cycle_collect,1859 17:51:59 INFO - PROCESS | 23267 | __end_cc_report 17:51:59 INFO - PROCESS | 23267 | __startTimestamp1460681519716__endTimestamp 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | ------- Summary: start ------- 17:51:59 INFO - PROCESS | 23267 | Number of tests: 14 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:4.09 (3.6%) stddev-sans-first:4.24 17:51:59 INFO - PROCESS | 23267 | Values: 113.0 115.0 106.0 112.0 112.0 113.0 101.0 111.0 112.0 111.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:155.00 stddev:20.42 (13.2%) stddev-sans-first:21.64 17:51:59 INFO - PROCESS | 23267 | Values: 156.0 133.0 154.0 182.0 134.0 153.0 165.0 136.0 188.0 131.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.53 17:51:59 INFO - PROCESS | 23267 | Values: 163.0 162.0 162.0 161.0 162.0 161.0 161.0 162.0 162.0 161.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#3] audio-fft Cycles:10 Average:89.00 Median:74.50 stddev:17.41 (23.4%) stddev-sans-first:18.09 17:51:59 INFO - PROCESS | 23267 | Values: 79.0 74.0 107.0 114.0 77.0 75.0 74.0 113.0 101.0 76.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:22.75 (24.2%) stddev-sans-first:23.62 17:51:59 INFO - PROCESS | 23267 | Values: 95.0 94.0 138.0 95.0 94.0 93.0 148.0 94.0 95.0 137.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:51:59 INFO - PROCESS | 23267 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.49 (1.0%) stddev-sans-first:1.56 17:51:59 INFO - PROCESS | 23267 | Values: 148.0 149.0 151.0 148.0 150.0 147.0 150.0 149.0 149.0 146.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:51:59 INFO - PROCESS | 23267 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:66.00 stddev:5.49 (8.3%) stddev-sans-first:5.78 17:51:59 INFO - PROCESS | 23267 | Values: 65.0 66.0 67.0 66.0 66.0 66.0 65.0 82.0 64.0 62.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:51:59 INFO - PROCESS | 23267 | Values: 65.0 66.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.71 (3.2%) stddev-sans-first:2.85 17:51:59 INFO - PROCESS | 23267 | Values: 84.0 84.0 83.0 82.0 85.0 85.0 92.0 85.0 86.0 84.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:141.50 stddev:10.76 (7.6%) stddev-sans-first:11.32 17:51:59 INFO - PROCESS | 23267 | Values: 139.0 146.0 137.0 135.0 136.0 136.0 144.0 146.0 171.0 138.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.50 stddev:3.06 (1.8%) stddev-sans-first:3.21 17:51:59 INFO - PROCESS | 23267 | Values: 171.0 171.0 170.0 172.0 175.0 173.0 174.0 179.0 171.0 168.0 17:51:59 INFO - PROCESS | 23267 | 17:51:59 INFO - PROCESS | 23267 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:1.78 (2.4%) stddev-sans-first:1.88 17:51:59 INFO - PROCESS | 23267 | Values: 73.0 77.0 73.0 73.0 73.0 72.0 71.0 71.0 71.0 72.0 17:51:59 INFO - PROCESS | 23267 | -------- Summary: end -------- 17:51:59 INFO - PROCESS | 23267 | 17:52:00 INFO - TEST-INFO | 23267: exit 0 17:52:00 INFO - TEST-OK | kraken | took 63435ms 17:52:00 INFO - SUITE-END | took 1181s 17:52:00 INFO - Completed test suite (00:19:41) 17:52:00 INFO - javascript benchmark 17:52:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.5781474964006, 2711.349276173719, 2711.7017128115917, 2716.8098233123687, 2743.0399360223923, 4674.0651869626045, 4706.976465117674, 4711.411073615798, 4741.288806679, 4749.382580264565, 4704.247320428732, 4730.597899178574, 4756.952430475694, 4772.451168115667, 4779.354787103749, 4213.641840443551, 4262.211490874182, 4265.765382903939, 4292.849750258742, 4438.134563760068, 4357.12857428514, 4379.934300985487, 4394.07724377881, 4407.933880991788, 4444.97777511112, 4231.936520952188, 4288.549702281278, 4298.591633794785, 4324.545922678105, 4349.934750978738, 4297.0, 4304.182205380999, 4309.987153019038, 4313.482382114135, 4350.782460876943, 4278.700490965633, 4295.763732994684, 4296.5059018213, 4325.091730736549, 4339.088791353819, 4488.281874900001, 4497.730136191806, 4552.863414097583, 4557.567031132037, 4625.7687115644085, 4940.777665005047, 5015.32293140425, 5034.0, 5035.791410061595, 5041.218611115283, 5047.192449208146, 5055.494450554915, 5060.418051924003, 5064.139096353629, 5084.669496482754, 4665.790039448233, 4700.882477938079, 4735.100330937111, 4778.832740854054, 4780.641451891122, 5140.126178549655, 5151.407588127413, 5155.32980712505, 5157.484251574812, 5162.793488260428, 4844.297576851407, 4951.108800415887, 4951.306817045616, 4953.702777833341, 5005.424376196711, 5018.372703412074, 5027.2207807789855, 5058.342415486037, 5090.363704536933, 5095.184770436712, 4909.337239472626, 4955.554000140005, 4955.603551715854, 4981.975090124526, 5030.245463180552, 4765.785539650655, 4855.8057677693205, 4907.263910413467, 4920.458749537548, 4960.107180707508, 4173.144505376391, 4303.569643035671, 4315.093830295673, 4315.3742707307265, 4319.416878721395, 3711.9814400928362, 3714.4428335749312, 3714.461403096536, 3751.2872554214614, 3760.9247815043545, 4377.102693947733, 4385.846495372647, 4386.0789234261165, 4388.9122217556105, 4433.312836510346, 4918.409790825124, 5018.498150185025, 5065.468125846806, 5104.183330667075, 5113.590912726973, 4346.521882592912, 4366.868993930188, 4369.126174764996, 4369.71596846204, 4411.558844115562, 4431.423914891108, 4504.572065653758, 4506.7295962241715, 4511.075229577928, 4558.270676691714, 4755.857324280346, 4783.6651434399255, 4797.088553174885, 4819.204831202812, 4833.492483289204, 5001.049800537886, 5040.798368065236, 5046.84859454217, 5050.292958985671, 5097.209932460474, 4651.3023046543285, 4768.880777980578, 4778.737169455713, 4789.616830653609, 4820.421549414093, 5009.3487846581165, 5015.423226329019, 5032.874178145576, 5072.213806859942, 5084.745762711924, 5075.137226671549, 5096.05722941257, 5097.770600323069, 5102.209157580581, 5106.10643137442, 4744.59670927975, 4804.735739534359, 4917.991811678526, 4935.851924442272, 4942.406911170682, 4855.587275081658, 4872.220444728827, 4872.342233798392, 4886.389201349832, 4915.483874193158, 4779.976100119477, 4795.472498025284, 4796.3285140079715, 4802.759862006956, 4837.927431088466, 4664.510226426312, 4866.0, 4950.0, 4952.504749525018, 4960.801567937387, 4789.425268967746, 4808.591269742111, 4810.518948105161, 4837.854864354075, 4847.491013443538], "value": 4621.017076882083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2017252491199, 579.9275090613673, 592.8962431574473, 602.7468463245435, 611.3977731934046, 26387.604185937227, 34848.47727284089, 35622.90336611291, 35674.2865142697, 35687.2862542749, 37539.624603754026, 38224.23551528968, 38261.426078608776, 38326.42510362347, 38327.616723832754, 7266.781996540112, 7493.475456718032, 7497.850042999136, 7749.806254843632, 7937.9680641516525, 7321.450891183183, 9808.705738827846, 10196.847047294297, 10212.540435680412, 10221.182305415587, 9903.752406189868, 9994.600215991351, 10004.549795259194, 10005.899941000605, 10010.799784004315, 7438.995735575682, 7769.72805951789, 9802.509874506282, 9910.90089099107, 9924.80150396988, 9766.90233097667, 10222.795544089076, 10229.744256393575, 10231.232657550714, 10236.0, 35565.11087222814, 36145.63854361449, 36205.27589448223, 36248.27503449943, 36290.8185459071, 2984.7462965647946, 3000.1449586867857, 3002.1293824790782, 3026.0, 3064.5862808520787, 27488.17535473939, 27638.723612763817, 28061.0, 29776.8511157445, 30250.54624180639, 3489.197484578561, 3490.371733088043, 3510.473428985647, 3557.217412169319, 3639.0720366306687, 167704.0, 167948.0, 168695.0, 223923.0, 224637.0, 54601.180982285296, 55499.722501388045, 55697.721511392185, 55734.09861309751, 55740.442595574335, 59277.701121842976, 61013.0, 61145.694271529246, 61162.69418652878, 61206.38793612096, 12749.42627581761, 12784.232946023269, 12800.743985120245, 12802.295873726847, 12812.487500499876, 10219.7445063874, 10653.467326633638, 11049.723756905982, 11548.826767598493, 11635.53457861693, 17989.280428782702, 18026.3690770825, 18039.54901127456, 18092.019755653735, 18165.81834181641, 6673.9332606673315, 6736.730530778812, 6783.93216067833, 6809.897851532231, 6857.5199736018, 898.5327629632685, 929.2705226397246, 939.4551160326994, 991.6925753016588, 1005.2249824756819, 28561.0, 28962.42075158485, 29140.708592914223, 29209.707902921124, 29541.556876646868, 967.4920666649924, 974.5711886769799, 1001.5643195210107, 1005.7485628592851, 1034.7649077991503, 15394.692106157814, 15522.37910483568, 15558.844411555965, 15567.766483502757, 15909.602259943362, 333481.0, 334192.0, 335178.0, 339874.0, 340031.0, 49301.26048109281, 50336.24495632568, 50597.747011264706, 50671.23993140106, 50765.0, 1054.314695447965, 1148.1388958281289, 1258.9685257868628, 1276.0, 1278.1117123599195, 26624.866875666274, 28051.43897122087, 28382.71617283801, 28526.85736571304, 28947.56578651364, 39214.0, 39301.2139757209, 39493.2101357977, 39514.802425987684, 39656.80171599239, 217898.0, 219369.0, 219881.0, 220405.0, 220552.0, 22878.65682014738, 25298.36754081089, 25932.0, 25933.481330373663, 25998.0, 39120.21759564849, 40039.39940900831, 40189.397159042055, 40640.79679601583, 41028.384574232005, 33783.01746008078, 33956.3208735819, 34756.82621586876, 34764.82617586896, 34881.65118348784, 34500.30999380049, 34510.13724656803, 34753.82623086868, 34904.0, 35144.64855351414, 34194.0, 34625.0, 34799.13002174966, 34891.0, 34904.47643285403, 31988.68011319857, 33721.3255734879, 33818.66181338155, 34469.655303447646, 34479.827600861834, 23433.765662343158, 23456.882715586315, 23484.412889677893, 23814.404639884142, 23889.28332150038], "value": 17378.333314331376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.67938931297715, 387.9844806207752, 393.4236343756396, 404.97975101244947, 405.7180259719496, 15628.687426251468, 16335.979165939105, 16484.587885302873, 16505.66988660226, 16523.50429487116, 15541.378344866192, 16473.258703358348, 17056.23246953887, 17195.82804171958, 17324.566885827862, 4774.474807771142, 4935.605151587864, 4951.653384263103, 4953.603711703073, 4964.329815474901, 3486.3201675673254, 5248.448912864152, 5541.833744987636, 5560.138178582326, 5566.86082847928, 5281.445448227938, 5532.3637781655025, 5534.806281780138, 5550.944490555104, 5553.555715542767, 6102.115193296947, 6124.816255512342, 6125.295591007024, 6130.080487926824, 6148.938510614904, 3392.3384939936723, 3578.982105089484, 3590.0665826885197, 3591.9281614367565, 5058.367704036996, 12258.877411225863, 12342.691432714164, 12359.938200308941, 13053.0, 20067.1973121075, 1913.7512123424005, 1921.0, 1922.5866438715602, 1945.2121890634317, 2071.4510654676524, 8689.826203475895, 9383.24934005278, 9567.521623918847, 9649.662261820802, 9753.366031207948, 1779.9288028478845, 1797.2451570340488, 1845.6493266279365, 1846.5014446099478, 1899.563100486882, 42916.78541607272, 54083.0, 71334.64332678355, 71401.64299178471, 72130.27869721288, 10095.44475053879, 10247.795044099077, 10282.177425806067, 10324.277300588887, 10482.580696772196, 14428.278586070865, 14479.276036198147, 14479.565613031626, 14482.565523034325, 14502.0, 7070.9914502051715, 7270.139650724956, 7323.084614423197, 7360.521566098187, 7406.777796666109, 6736.5284430090405, 6764.72941082361, 6774.45804335652, 6796.966015169893, 6907.171139463297, 4434.800433980478, 4463.977680111643, 4502.0, 4515.07440974606, 4581.198290299184, 1705.4372057221087, 2870.4833130036377, 3077.938441231163, 3099.838165071659, 3380.1042723678247, 879.2218886285556, 882.3867412148495, 895.3106108296575, 908.2597682888425, 936.4942930817418, 15903.363865445253, 16121.677566448605, 17097.914510427618, 17256.482305530855, 18317.17572709231, 875.5578432891476, 887.4719541872704, 890.7862113092812, 896.7130518234233, 945.2438049560325, 9409.670661526814, 9691.51542422876, 9716.271279654055, 9778.364406313567, 9831.557579908922, 394273.0, 402390.0, 408450.0, 410972.0, 413213.0, 75436.62281688556, 81110.59444702738, 82827.58586207152, 83756.0, 84621.0, 964.8022155458115, 970.427447805798, 999.8250306196387, 1002.0880998291519, 1004.3271008424373, 15273.312700928707, 15449.613759656098, 15579.922100389425, 15605.0, 15943.521694349189, 32695.836520817244, 33852.49221261634, 35036.824815875756, 35199.47200791939, 35540.466892997145, 43829.90425239394, 45466.0, 47113.0, 48715.269270961675, 48802.02395952132, 7352.37504812097, 7466.887996679946, 7535.886961695689, 7697.653605587874, 7792.766217013499, 10838.67483975482, 11148.442577871236, 11626.88373116258, 11634.243774154653, 11929.0, 9971.750706232402, 10083.697489075339, 10311.0, 10381.338985762544, 10394.688159355232, 9652.469114198786, 9942.652007179713, 10240.283180177614, 10301.381917084998, 10651.147908167173, 10165.390076595428, 10469.842952355873, 10557.683269501927, 10663.253572249869, 10679.09227715653, 7503.0, 7575.393968482618, 7591.240875912365, 7681.923180768121, 7783.571903545359, 10362.896371036193, 10420.68737937863, 10422.895771042193, 10468.738281543023, 10513.632022879163], "value": 8200.792743289501, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.9491220351185, 1450.028480917785, 1476.527511196417, 1639.8770092243085, 1789.454216463978, 7338.412926965843, 7662.233776622335, 7677.769666909988, 7679.769606911787, 7680.270374314438, 7461.40308775298, 7568.545887246769, 7572.318491335793, 7602.885956710654, 7604.125525564548, 1919.8752081114753, 2181.301983365324, 2194.1991173221777, 2227.565624703175, 2258.627326491127, 2243.6522339037474, 2262.253456359406, 2265.852719573231, 2268.7617800130915, 2269.251147121446, 2174.8038578781684, 2231.163313757341, 2237.1498830444407, 2239.9552008959813, 2242.237639202671, 1906.5614908571038, 2128.2976617716195, 2202.8237740980685, 2208.569328980849, 2209.2267706302828, 2130.7762684918016, 2140.1332460353583, 2150.849440539163, 2152.257471172443, 2198.2855571939185, 7605.391568674493, 7633.732819351296, 7690.461667683265, 7695.538267703956, 7703.499272547267, 4516.36770852081, 4656.068786242765, 4657.464391594942, 4671.556202160789, 4674.6209868089, 2943.2200466876293, 2945.0428610701606, 3020.0486846643457, 3020.1241639924397, 3056.3581647853975, 990.6730778842965, 1017.8931212222758, 1041.1358572384902, 1042.6038105519854, 1055.8469021991846, 10440.895591044069, 10479.214058945534, 10501.317414367964, 10516.684499464951, 10537.525811338508, 4092.529359123679, 4355.1507456045765, 4357.67317451186, 4367.781610919441, 4386.0, 8903.821923561492, 9043.547822608843, 9047.77380565478, 9078.636854525745, 9105.77235569116, 4170.812313445902, 4704.482506924304, 4713.387259656222, 4723.6929599575915, 4730.361401210861, 4206.432131662247, 4291.742495450283, 4298.4197133387215, 4325.891852703708, 4329.415528903558, 3577.8926632201074, 3674.0, 3735.1595890924323, 3745.7752534847996, 3788.5264341957254, 1231.655136561764, 1244.5333000124954, 1254.9058820588493, 1264.607971528829, 1271.8092286156966, 822.387321445515, 844.2359664503634, 854.256796586961, 883.5228976352697, 888.1695614600369, 5230.607704422184, 5311.681299122065, 5327.067763141435, 5346.224797404355, 5375.677459352373, 422.5900876150129, 431.6201742466672, 438.9912201755947, 439.6658539509995, 441.24326779573187, 3721.2557488502407, 3731.029932217643, 3767.1147280389087, 3802.980985095057, 3809.7904615245875, 9210.539473026322, 9568.0, 9687.51562421876, 9697.127258546765, 9700.078492543196, 9564.76088097803, 9573.617055317849, 9581.425114493153, 9585.760355991017, 9591.280653950982, 7142.92857071433, 7246.818829529304, 7253.455990800711, 7326.3040011198855, 7344.889826652605, 5371.140617501181, 5394.67830381559, 5400.702961337164, 5414.29614150158, 5422.539084177889, 8607.48355098696, 8673.522956237215, 8676.869846952175, 8718.520481373585, 8786.604602793017, 8497.702580409656, 8763.474191548528, 8948.552572371225, 8948.821023579621, 8980.595873185592, 5811.476967072984, 5856.94143058581, 6333.20834895638, 6666.100076489612, 6858.588484690935, 7331.74338898136, 7435.4795164337975, 7457.77626671179, 7462.104547454123, 7474.439417043852, 6751.662416879039, 6842.486813488908, 6856.4514838813775, 6918.238993710587, 6919.688614012281, 6595.208574971034, 6618.205815302194, 6620.966895165493, 6744.494162937701, 6795.38841504267, 6306.936930630818, 6405.647689377129, 6426.4216220540375, 6441.71012304438, 6464.09502669636, 4542.6365890728, 4631.745254011062, 4742.976285118552, 4760.880977975578, 4772.570468657698, 4783.258594917794, 4856.95143048565, 4893.730844803427, 4944.381952255968, 4950.653454258311], "value": 4102.569934922931, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.86775554267217, 321.43427567481234, 325.80126123064935, 326.4368963537896, 329.9785513941595, 5104.617153713472, 5179.3007943927605, 5188.16989281715, 5199.948000519994, 5226.372835259769, 5101.234814777785, 5106.285120083191, 5112.667676601028, 5123.871903202422, 5127.512886275807, 3804.771713697187, 3884.4173373993845, 4040.1919616076757, 4048.554658987509, 4057.5942405759333, 4016.8995775105564, 4021.195760847842, 4049.9392509112386, 4052.128792309653, 4061.3501839705655, 3794.867179648699, 4000.3199456092534, 4012.1975604878994, 4012.739171953828, 4029.5970402959615, 3876.2247550489874, 4002.3596224603925, 4019.839206431739, 4020.8190631421658, 4024.637782599551, 3559.48387483816, 3561.857525698969, 3569.6965757910607, 3569.7322700797286, 3570.732195085379, 4915.239841521239, 4928.0, 4930.619426560533, 4936.593070974755, 4965.329680493123, 4531.501534831166, 4566.908661826745, 4627.838025669085, 4640.744759038252, 4649.744264065475, 5329.706866122362, 5359.973200133974, 5366.168243922199, 5368.242230438669, 5372.301600791911, 3909.765414075136, 3913.7064720146104, 3916.667083297923, 3927.998360418104, 3934.9213015739524, 5498.99999999996, 5609.5792815539, 5627.296587926509, 5635.436456354373, 5640.802571910004, 3989.082511022481, 4012.3981402789814, 4014.5182578090817, 4022.8276730565167, 4031.0, 4046.7774272414713, 4064.4919385076864, 4068.6541643960004, 4113.621936651196, 4115.6295933365545, 4511.481179664315, 4547.636189104864, 4628.95371046292, 4637.652176086807, 4642.0, 5407.0, 5411.188321751769, 5426.538744206787, 5427.6200665953, 5429.511343979061, 1413.9363728632236, 1427.664498842771, 1436.590571687064, 1437.6980834024762, 1440.625437386287, 917.8022680402006, 958.1472489484364, 961.2550273537925, 970.839811431106, 986.1223511075149, 4747.264174053027, 4752.714837109785, 4787.138315103245, 4788.928166077511, 4798.592119669797, 5553.0, 5555.666660000413, 5556.111022236503, 5560.638558493685, 5565.080047383646, 4673.556012178838, 4715.834945776881, 4763.45220299663, 4779.115863565252, 4783.354247176587, 2947.882084716587, 2958.5266357382716, 2966.6440027196873, 2974.836383998901, 2976.7320941115404, 5134.845954621367, 5166.896662066738, 5175.171972484384, 5191.480851914778, 5219.138842091088, 5459.235707001023, 5632.831015069554, 5655.123455864347, 5681.857953551194, 5688.544916406678, 5206.8958620828125, 5220.712860792617, 5226.869328266824, 5228.215767634885, 5234.581233501311, 5419.376771671308, 5523.8066667666435, 5540.556755459473, 5545.140503222007, 5559.19391688211, 5368.2484452177505, 5451.509364157245, 5460.481254280837, 5462.9180562292395, 5465.316835395575, 5192.0924282401975, 5220.347456567929, 5229.424763276113, 5232.476752324889, 5233.528982391603, 3945.5659877412886, 4001.899477643671, 4048.0689441429226, 4051.756894586334, 4056.513218413809, 5500.669959802424, 5505.311836020497, 5505.339359276913, 5522.834314970557, 5526.281583394133, 5246.921296180637, 5297.17893726473, 5302.893942121059, 5312.840614781563, 5326.508577598279, 5146.665466744649, 5294.947050529446, 5310.920336194883, 5315.734213289397, 5320.654157479751, 5060.987802439453, 5188.948110518997, 5248.343957005374, 5251.26482292487, 5262.921056184084, 5208.317716375994, 5467.753951072132, 5470.589705772003, 5474.753636086306, 5475.4524547544925, 5324.653897496651, 5329.09405401075, 5334.733263336895, 5338.733063346895, 5338.839834804962], "value": 4080.3732179999656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.804842692473, 760.3081196111536, 771.756896577578, 779.1857508903196, 782.7221336425565, 12086.274823510585, 12623.936880315585, 12684.556040538582, 12692.746145077093, 12706.0, 13250.403731832066, 13293.069485136044, 13315.733685326288, 13362.799558006613, 13364.264965426897, 648.6237981970446, 803.871380579109, 818.4189225649795, 818.8648872935988, 819.1112642782558, 780.9375249980017, 804.5534728225832, 804.6580203413555, 807.4267270238138, 809.7570728781371, 849.2484151525882, 850.2517784349764, 854.0520022774715, 854.1885209051395, 854.1927878155146, 669.5045666206972, 824.9010118785724, 845.7547311279721, 847.4618617178105, 848.707196017373, 618.4588485075559, 619.0868469008221, 619.7118339971889, 621.8973869311558, 623.965681887496, 11974.521019159223, 11980.161388702794, 11981.880181198163, 12048.036157107497, 12056.698582535419, 11995.700107497383, 12507.187032842836, 12582.68543286416, 12741.872581274161, 12812.61562153137, 10070.194384449227, 10106.39361638304, 10190.337628054152, 10301.330413523172, 10305.227107966857, 3261.8858339958224, 3287.112479630486, 3309.652486488908, 3360.2775403288165, 3373.3927892979254, 50913.49086509162, 51214.74392628013, 51307.486925130645, 51815.0, 52225.216621750704, 9723.270754693285, 9799.902000980042, 9858.556364963593, 9918.30571859963, 9959.800803984024, 16763.078030708184, 16827.579310517336, 16853.915730421268, 16896.831031689526, 16909.830901690824, 6168.568200226031, 6388.105665206875, 6560.8359791005605, 6682.431993280626, 6769.72921083161, 3698.14942563212, 3755.3803622401997, 3758.229562939591, 3771.2080463102507, 3798.1454172810895, 2845.9715402845704, 2944.748481895186, 2958.304798372381, 2959.245392424918, 2960.4523163214876, 517.1338008835186, 522.4227228912074, 525.8562626287809, 527.5146864884316, 530.2629345210161, 614.4270667092259, 626.2172284644195, 629.2197674883204, 634.9015902535115, 635.7488791927162, 7260.310270524292, 7461.626918654046, 7527.774166775005, 7555.13115991657, 7920.683172673029, 519.8466452396552, 614.2168734862996, 619.9008158694587, 621.5183232994466, 633.5343522510951, 3660.213054193361, 3751.9869635198343, 3817.3701339279264, 3861.4400911867624, 3865.1496670732395, 56053.719731401085, 58789.0, 58831.70584147052, 58905.11642325368, 59061.70469147713, 49288.50711492911, 50590.24114638283, 50707.43633073041, 51322.23016654753, 51512.0, 46370.0, 46478.0, 46492.302615460794, 46660.06679866451, 47371.76314118476, 7136.750213742494, 7228.241034691492, 7291.963540182265, 7425.925740742523, 7463.290987356192, 29989.400211995202, 30830.229244269074, 30934.845325773225, 30957.380852382375, 31194.844025779727, 39739.40390894197, 40468.0, 41279.0, 41975.7901210492, 42079.57920420756, 8858.512781797062, 9166.633334666538, 10417.801952775528, 10460.163186944874, 10555.419451930218, 11444.656660300205, 11602.589641434262, 11670.824937626112, 11705.824412633987, 11954.641360759191, 8085.0, 10804.567817287221, 10944.835827462754, 10973.615923442641, 11099.5560177592, 10540.947295263475, 10634.680959571226, 10740.516676749408, 11001.119910407308, 11006.119510438986, 9468.621255149717, 9667.806643867223, 9773.218142548722, 9819.705408837746, 9911.65309214174, 9052.275817934418, 9290.16388525036, 9376.015518370747, 9377.812443751223, 9404.435733855991, 8971.461712297283, 9120.726378208665, 9154.267658587163, 9155.816883662157, 9290.62837486493], "value": 5964.699905608088, "unit": "score"}], "name": "dromaeo_css", "value": 6353.291981883896, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 106.0, 112.0, 112.0, 113.0, 101.0, 111.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 154.0, 182.0, 134.0, 153.0, 165.0, 136.0, 188.0, 131.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 107.0, 114.0, 77.0, 75.0, 74.0, 113.0, 101.0, 76.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 138.0, 95.0, 94.0, 93.0, 148.0, 94.0, 95.0, 137.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 151.0, 148.0, 150.0, 147.0, 150.0, 149.0, 149.0, 146.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 82.0, 64.0, 62.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 82.0, 85.0, 85.0, 92.0, 85.0, 86.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 146.0, 137.0, 135.0, 136.0, 136.0, 144.0, 146.0, 171.0, 138.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 170.0, 172.0, 175.0, 173.0, 174.0, 179.0, 171.0, 168.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 73.0, 73.0, 73.0, 72.0, 71.0, 71.0, 71.0, 72.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1589.1, "alertThreshold": 2.0}]} 17:52:00 INFO - Return code: 0 17:52:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:52:01 ERROR - # TBPL SUCCESS # 17:52:01 INFO - Running post-action listener: _resource_record_post_action 17:52:01 INFO - Running post-run listener: _resource_record_post_run 17:52:02 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516345856; Read time: 4; Write time: 588944 17:52:02 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233369600; Read time: 0; Write time: 391904 17:52:02 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282378240; Read time: 4; Write time: 197040 17:52:02 INFO - Running post-run listener: _upload_blobber_files 17:52:02 INFO - Blob upload gear active. 17:52:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:52:02 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 17:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:52:02 INFO - (blobuploader) - INFO - Open directory for files ... 17:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:52:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:03 INFO - (blobuploader) - INFO - Done attempting. 17:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:52:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:04 INFO - (blobuploader) - INFO - Done attempting. 17:52:04 INFO - (blobuploader) - INFO - Iteration through files over. 17:52:04 INFO - Return code: 0 17:52:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:52:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:52:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8677efc0a480abef85c2636eb4f0c0aa6bf25b14bfc017202a04993fc0d1f6bf8c873c1bb1b80409c6ec15e3511fd593b45fd63a1c768e4bac039b3fcdd95f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50a06b19edd587d685f3b035730e8e4f665c7772a3f983b148b444ee8a287f7f6d996111d636420eb03e3a9ec264641c20b9d0c22967e279401a9948dd774fe2"} 17:52:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:52:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:52:04 INFO - Contents: 17:52:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8677efc0a480abef85c2636eb4f0c0aa6bf25b14bfc017202a04993fc0d1f6bf8c873c1bb1b80409c6ec15e3511fd593b45fd63a1c768e4bac039b3fcdd95f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50a06b19edd587d685f3b035730e8e4f665c7772a3f983b148b444ee8a287f7f6d996111d636420eb03e3a9ec264641c20b9d0c22967e279401a9948dd774fe2"} 17:52:04 INFO - Running post-run listener: copy_logs_to_upload_dir 17:52:04 INFO - Copying logs to upload dir... 17:52:04 INFO - mkdir: /builds/slave/test/build/upload/logs 17:52:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.389765 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-14 17:52:03.241391) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:52:03.244440) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8677efc0a480abef85c2636eb4f0c0aa6bf25b14bfc017202a04993fc0d1f6bf8c873c1bb1b80409c6ec15e3511fd593b45fd63a1c768e4bac039b3fcdd95f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50a06b19edd587d685f3b035730e8e4f665c7772a3f983b148b444ee8a287f7f6d996111d636420eb03e3a9ec264641c20b9d0c22967e279401a9948dd774fe2"} build_url:https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/ShMtjn7HTauXeMw5kn4QGA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8677efc0a480abef85c2636eb4f0c0aa6bf25b14bfc017202a04993fc0d1f6bf8c873c1bb1b80409c6ec15e3511fd593b45fd63a1c768e4bac039b3fcdd95f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50a06b19edd587d685f3b035730e8e4f665c7772a3f983b148b444ee8a287f7f6d996111d636420eb03e3a9ec264641c20b9d0c22967e279401a9948dd774fe2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:52:03.268738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:52:03.269051) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1460678826.729689-1714473334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:52:03.353819) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:52:03.354157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:52:03.354454) ========= ========= Total master_lag: 0.16 =========