builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1461477097.4 results: success (0) buildid: 20160423200744 builduid: fb54db8278d74430a046e3cc41a1c1c2 revision: 2b7291cc565421eebd5328f09dede6ff40ce0b42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.403991) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.404502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.404787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.422582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.423005) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 22:51:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 5.09M=0.002s 2016-04-23 22:51:37 (5.09 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069995 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.506526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.506913) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017732 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.556924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:37.557289) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2b7291cc565421eebd5328f09dede6ff40ce0b42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2b7291cc565421eebd5328f09dede6ff40ce0b42 --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=c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 22:51:37,661 truncating revision to first 12 chars 2016-04-23 22:51:37,661 Setting DEBUG logging. 2016-04-23 22:51:37,661 attempt 1/10 2016-04-23 22:51:37,661 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2b7291cc5654?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 22:51:37,901 unpacking tar archive at: mozilla-aurora-2b7291cc5654/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:38.098939) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:38.099266) ========= script_repo_revision: 2b7291cc565421eebd5328f09dede6ff40ce0b42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:38.099672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:38.099942) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 22:51:38.110061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-23 22:51:38.110347) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:51:38 INFO - MultiFileLogger online at 20160423 22:51:38 in /builds/slave/test 22:51:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:51:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:51:38 INFO - {'append_to_log': False, 22:51:38 INFO - 'base_work_dir': '/builds/slave/test', 22:51:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:51:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:51:38 INFO - 'branch': 'Mozilla-Aurora', 22:51:38 INFO - 'buildbot_json_path': 'buildprops.json', 22:51:38 INFO - 'config_files': ('talos/linux_config.py',), 22:51:38 INFO - 'default_actions': ('clobber', 22:51:38 INFO - 'read-buildbot-config', 22:51:38 INFO - 'download-and-extract', 22:51:38 INFO - 'populate-webroot', 22:51:38 INFO - 'create-virtualenv', 22:51:38 INFO - 'install', 22:51:38 INFO - 'run-tests'), 22:51:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:51:38 INFO - 'download_minidump_stackwalk': True, 22:51:38 INFO - 'download_symbols': 'ondemand', 22:51:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:51:38 INFO - 'tooltool.py': '/tools/tooltool.py', 22:51:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:51:38 INFO - '/tools/misc-python/virtualenv.py')}, 22:51:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:51:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:51:38 INFO - 'installer_path': 'installer.exe', 22:51:38 INFO - 'log_level': 'info', 22:51:38 INFO - 'log_name': 'talos', 22:51:38 INFO - 'log_to_console': True, 22:51:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:51:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:51:38 INFO - 'opt_config_files': (), 22:51:38 INFO - 'pip_index': False, 22:51:38 INFO - 'sps_profile': False, 22:51:38 INFO - 'sps_profile_interval': 0, 22:51:38 INFO - 'suite': 'dromaeojs', 22:51:38 INFO - 'system_bits': '32', 22:51:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:51:38 INFO - 'title': 'talos-linux64-ix-004', 22:51:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:51:38 INFO - 'use_talos_json': True, 22:51:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:51:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:51:38 INFO - 'work_dir': 'build'} 22:51:38 INFO - ##### 22:51:38 INFO - ##### Running clobber step. 22:51:38 INFO - ##### 22:51:38 INFO - Running pre-action listener: _resource_record_pre_action 22:51:38 INFO - Running main action method: clobber 22:51:38 INFO - rmtree: /builds/slave/test/build 22:51:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:51:38 INFO - Running post-action listener: _resource_record_post_action 22:51:38 INFO - ##### 22:51:38 INFO - ##### Running read-buildbot-config step. 22:51:38 INFO - ##### 22:51:38 INFO - Running pre-action listener: _resource_record_pre_action 22:51:38 INFO - Running main action method: read_buildbot_config 22:51:38 INFO - Using buildbot properties: 22:51:38 INFO - { 22:51:38 INFO - "project": "", 22:51:38 INFO - "product": "firefox", 22:51:38 INFO - "script_repo_revision": "production", 22:51:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 22:51:38 INFO - "repository": "", 22:51:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 22:51:38 INFO - "buildid": "20160423200744", 22:51:38 INFO - "pgo_build": "True", 22:51:38 INFO - "basedir": "/builds/slave/test", 22:51:38 INFO - "buildnumber": 279, 22:51:38 INFO - "slavename": "talos-linux64-ix-004", 22:51:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:51:38 INFO - "platform": "ubuntu64_hw", 22:51:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:51:38 INFO - "branch": "mozilla-aurora", 22:51:38 INFO - "repo_path": "releases/mozilla-aurora", 22:51:38 INFO - "revision": "2b7291cc565421eebd5328f09dede6ff40ce0b42", 22:51:38 INFO - "stage_platform": "linux64-pgo", 22:51:38 INFO - "builduid": "fb54db8278d74430a046e3cc41a1c1c2", 22:51:38 INFO - "slavebuilddir": "test" 22:51:38 INFO - } 22:51:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 22:51:38 INFO - Running post-action listener: _resource_record_post_action 22:51:38 INFO - ##### 22:51:38 INFO - ##### Running download-and-extract step. 22:51:38 INFO - ##### 22:51:38 INFO - Running pre-action listener: _resource_record_pre_action 22:51:38 INFO - Running main action method: download_and_extract 22:51:38 INFO - mkdir: /builds/slave/test/build/tests 22:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:38 INFO - https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:51:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:51:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:51:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:51:39 INFO - Downloaded 1448 bytes. 22:51:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:51:39 INFO - Using the following test package requirements: 22:51:39 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:51:39 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:51:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:51:39 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:51:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:51:39 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:51:39 INFO - u'jsshell-linux-x86_64.zip'], 22:51:39 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:51:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:51:39 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:51:39 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:51:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:51:39 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:51:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:51:39 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:51:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:51:39 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:51:39 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:51:39 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:51:39 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:51:39 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')]} 22:51:39 INFO - https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:51:41 INFO - Downloaded 23358968 bytes. 22:51:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:51:42 INFO - Return code: 0 22:51:42 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:51:42 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')]} 22:51:42 INFO - https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:51:43 INFO - Downloaded 23358968 bytes. 22:51:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:51:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:51:45 INFO - Return code: 0 22:51: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')]} 22:51:45 INFO - https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:51:46 INFO - Downloaded 10845194 bytes. 22:51:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:51:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:51:46 INFO - Return code: 0 22:51:46 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')]} 22:51:46 INFO - https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:51:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:51:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:51:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:51:48 INFO - Downloaded 60839413 bytes. 22:51:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:51:48 INFO - mkdir: /builds/slave/test/properties 22:51:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:51:48 INFO - Writing to file /builds/slave/test/properties/build_url 22:51:48 INFO - Contents: 22:51:48 INFO - build_url:https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:51:49 INFO - Running post-action listener: _resource_record_post_action 22:51:49 INFO - Running post-action listener: set_extra_try_arguments 22:51:49 INFO - ##### 22:51:49 INFO - ##### Running populate-webroot step. 22:51:49 INFO - ##### 22:51:49 INFO - Running pre-action listener: _resource_record_pre_action 22:51:49 INFO - Running main action method: populate_webroot 22:51:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:51:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:51:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:51:49 INFO - '--tppagecycles', 22:51:49 INFO - '7'], 22:51:49 INFO - 'tests': ['tsvgm']}}, 22:51:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:51:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:51:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:51:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:51:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:49 INFO - 'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:49 INFO - 'tests': ['damp', 'tps']}, 22:51:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:49 INFO - 'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['damp', 'tps']}, 22:51:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:51:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:51:49 INFO - 'other': {'tests': ['a11yr', 22:51:49 INFO - 'ts_paint', 22:51:49 INFO - 'tpaint', 22:51:49 INFO - 'sessionrestore', 22:51:49 INFO - 'sessionrestore_no_auto_restore', 22:51:49 INFO - 'tabpaint']}, 22:51:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['a11yr', 22:51:49 INFO - 'ts_paint', 22:51:49 INFO - 'tpaint', 22:51:49 INFO - 'sessionrestore', 22:51:49 INFO - 'sessionrestore_no_auto_restore', 22:51:49 INFO - 'tabpaint']}, 22:51:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['a11yr', 22:51:49 INFO - 'ts_paint', 22:51:49 INFO - 'tpaint', 22:51:49 INFO - 'sessionrestore', 22:51:49 INFO - 'sessionrestore_no_auto_restore', 22:51:49 INFO - 'tabpaint']}, 22:51:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['a11yr', 22:51:49 INFO - 'ts_paint', 22:51:49 INFO - 'tpaint', 22:51:49 INFO - 'sessionrestore', 22:51:49 INFO - 'sessionrestore_no_auto_restore', 22:51:49 INFO - 'tabpaint']}, 22:51:49 INFO - 'other_l64': {'tests': ['a11yr', 22:51:49 INFO - 'ts_paint', 22:51:49 INFO - 'tpaint', 22:51:49 INFO - 'sessionrestore', 22:51:49 INFO - 'sessionrestore_no_auto_restore', 22:51:49 INFO - 'tabpaint']}, 22:51:49 INFO - 'other_nol64': {'tests': ['a11yr', 22:51:49 INFO - 'ts_paint', 22:51:49 INFO - 'tpaint', 22:51:49 INFO - 'sessionrestore', 22:51:49 INFO - 'sessionrestore_no_auto_restore', 22:51:49 INFO - 'tabpaint']}, 22:51:49 INFO - 'svgr': {'tests': ['tsvgx', 22:51:49 INFO - 'tsvgr_opacity', 22:51:49 INFO - 'tart', 22:51:49 INFO - 'tscrollx', 22:51:49 INFO - 'cart']}, 22:51:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['tsvgx', 22:51:49 INFO - 'tsvgr_opacity', 22:51:49 INFO - 'tart', 22:51:49 INFO - 'tscrollx', 22:51:49 INFO - 'cart']}, 22:51:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:49 INFO - 'tests': ['tp5o']}, 22:51:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:49 INFO - 'talos_options': ['--e10s'], 22:51:49 INFO - 'tests': ['tp5o']}, 22:51:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:49 INFO - 'talos_options': ['--xperf_path', 22:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:49 INFO - 'tests': ['tp5n']}, 22:51:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:49 INFO - 'talos_options': ['--e10s', 22:51:49 INFO - '--xperf_path', 22:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:49 INFO - 'tests': ['tp5n']}}, 22:51:49 INFO - 'talos.zip': {'path': '', 22:51:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:51:49 INFO - Running post-action listener: _resource_record_post_action 22:51:49 INFO - ##### 22:51:49 INFO - ##### Running create-virtualenv step. 22:51:49 INFO - ##### 22:51:49 INFO - Running pre-action listener: _resource_record_pre_action 22:51:49 INFO - Running main action method: create_virtualenv 22:51:49 INFO - Creating virtualenv /builds/slave/test/build/venv 22:51:49 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 22:51:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:51:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:51:49 INFO - Using real prefix '/usr' 22:51:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:51:49 INFO - Installing distribute.............................................................................................................................................................................................done. 22:51:51 INFO - Installing pip.................done. 22:51:51 INFO - Return code: 0 22:51:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:51: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')]} 22:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:51:51 INFO - Using env: {'DISPLAY': ':0', 22:51:51 INFO - 'HOME': '/home/cltbld', 22:51:51 INFO - 'LANG': 'en_US.UTF-8', 22:51:51 INFO - 'LANGUAGE': 'en_US:en', 22:51:51 INFO - 'LOGNAME': 'cltbld', 22:51:51 INFO - 'MAIL': '/var/mail/cltbld', 22:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:51 INFO - 'MOZ_NO_REMOTE': '1', 22:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:51 INFO - 'NO_EM_RESTART': '1', 22:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:51 INFO - 'PWD': '/builds/slave/test', 22:51:51 INFO - 'SHELL': '/bin/bash', 22:51:51 INFO - 'SHLVL': '1', 22:51:51 INFO - 'TERM': 'linux', 22:51:51 INFO - 'TMOUT': '86400', 22:51:51 INFO - 'USER': 'cltbld', 22:51:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:51 INFO - '_': '/tools/buildbot/bin/python'} 22:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:51 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 22:51:51 INFO - Cleaning up... 22:51:51 INFO - Return code: 0 22:51:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:51: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')]} 22:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:51:51 INFO - Using env: {'DISPLAY': ':0', 22:51:51 INFO - 'HOME': '/home/cltbld', 22:51:51 INFO - 'LANG': 'en_US.UTF-8', 22:51:51 INFO - 'LANGUAGE': 'en_US:en', 22:51:51 INFO - 'LOGNAME': 'cltbld', 22:51:51 INFO - 'MAIL': '/var/mail/cltbld', 22:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:51 INFO - 'MOZ_NO_REMOTE': '1', 22:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:51 INFO - 'NO_EM_RESTART': '1', 22:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:51 INFO - 'PWD': '/builds/slave/test', 22:51:51 INFO - 'SHELL': '/bin/bash', 22:51:51 INFO - 'SHLVL': '1', 22:51:51 INFO - 'TERM': 'linux', 22:51:51 INFO - 'TMOUT': '86400', 22:51:51 INFO - 'USER': 'cltbld', 22:51:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:51 INFO - '_': '/tools/buildbot/bin/python'} 22:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:52 INFO - Downloading/unpacking psutil>=0.7.1 22:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:51:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:54 INFO - Installing collected packages: psutil 22:51:54 INFO - Running setup.py install for psutil 22:51:54 INFO - building 'psutil._psutil_linux' extension 22:51:54 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 22:51:54 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 22:51:54 INFO - building 'psutil._psutil_posix' extension 22:51:54 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 22:51:54 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 22:51:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:54 INFO - Successfully installed psutil 22:51:54 INFO - Cleaning up... 22:51:54 INFO - Return code: 0 22:51:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:51:54 INFO - Using env: {'DISPLAY': ':0', 22:51:54 INFO - 'HOME': '/home/cltbld', 22:51:54 INFO - 'LANG': 'en_US.UTF-8', 22:51:54 INFO - 'LANGUAGE': 'en_US:en', 22:51:54 INFO - 'LOGNAME': 'cltbld', 22:51:54 INFO - 'MAIL': '/var/mail/cltbld', 22:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:54 INFO - 'MOZ_NO_REMOTE': '1', 22:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:54 INFO - 'NO_EM_RESTART': '1', 22:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:54 INFO - 'PWD': '/builds/slave/test', 22:51:54 INFO - 'SHELL': '/bin/bash', 22:51:54 INFO - 'SHLVL': '1', 22:51:54 INFO - 'TERM': 'linux', 22:51:54 INFO - 'TMOUT': '86400', 22:51:54 INFO - 'USER': 'cltbld', 22:51:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:54 INFO - '_': '/tools/buildbot/bin/python'} 22:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:51:56 INFO - Installing collected packages: mozsystemmonitor 22:51:56 INFO - Running setup.py install for mozsystemmonitor 22:51:56 INFO - Successfully installed mozsystemmonitor 22:51:56 INFO - Cleaning up... 22:51:56 INFO - Return code: 0 22:51:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:51: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')]} 22:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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', '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 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:51: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:51: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 blobuploader==1.2.4 22:51:56 INFO - Using env: {'DISPLAY': ':0', 22:51:56 INFO - 'HOME': '/home/cltbld', 22:51:56 INFO - 'LANG': 'en_US.UTF-8', 22:51:56 INFO - 'LANGUAGE': 'en_US:en', 22:51:56 INFO - 'LOGNAME': 'cltbld', 22:51:56 INFO - 'MAIL': '/var/mail/cltbld', 22:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:56 INFO - 'MOZ_NO_REMOTE': '1', 22:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:56 INFO - 'NO_EM_RESTART': '1', 22:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:51:56 INFO - 'PWD': '/builds/slave/test', 22:51:56 INFO - 'SHELL': '/bin/bash', 22:51:56 INFO - 'SHLVL': '1', 22:51:56 INFO - 'TERM': 'linux', 22:51:56 INFO - 'TMOUT': '86400', 22:51:56 INFO - 'USER': 'cltbld', 22:51:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:56 INFO - '_': '/tools/buildbot/bin/python'} 22:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:57 INFO - Downloading/unpacking blobuploader==1.2.4 22:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:59 INFO - Downloading blobuploader-1.2.4.tar.gz 22:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:51:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:52:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:52: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 22:52: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 22:52: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 22:52: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 22:52: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 22:52: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 22:52:00 INFO - Downloading docopt-0.6.1.tar.gz 22:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:52:00 INFO - Installing collected packages: blobuploader, requests, docopt 22:52:00 INFO - Running setup.py install for blobuploader 22:52:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:52:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:52:00 INFO - Running setup.py install for requests 22:52:01 INFO - Running setup.py install for docopt 22:52:01 INFO - Successfully installed blobuploader requests docopt 22:52:01 INFO - Cleaning up... 22:52:01 INFO - Return code: 0 22:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:01 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 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:52:01 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 22:52:01 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 22:52:01 INFO - Using env: {'DISPLAY': ':0', 22:52:01 INFO - 'HOME': '/home/cltbld', 22:52:01 INFO - 'LANG': 'en_US.UTF-8', 22:52:01 INFO - 'LANGUAGE': 'en_US:en', 22:52:01 INFO - 'LOGNAME': 'cltbld', 22:52:01 INFO - 'MAIL': '/var/mail/cltbld', 22:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:01 INFO - 'MOZ_NO_REMOTE': '1', 22:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:01 INFO - 'NO_EM_RESTART': '1', 22:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:01 INFO - 'PWD': '/builds/slave/test', 22:52:01 INFO - 'SHELL': '/bin/bash', 22:52:01 INFO - 'SHLVL': '1', 22:52:01 INFO - 'TERM': 'linux', 22:52:01 INFO - 'TMOUT': '86400', 22:52:01 INFO - 'USER': 'cltbld', 22:52:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:01 INFO - '_': '/tools/buildbot/bin/python'} 22:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:52:02 INFO - Running setup.py (path:/tmp/pip-iv3OZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:52:02 INFO - Running setup.py (path:/tmp/pip-vH_H6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:52:02 INFO - Running setup.py (path:/tmp/pip-EEKwNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:52:02 INFO - Running setup.py (path:/tmp/pip-Pevj4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:52:02 INFO - Running setup.py (path:/tmp/pip-MPi6VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:52:02 INFO - Running setup.py (path:/tmp/pip-wNxjs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:52:02 INFO - Running setup.py (path:/tmp/pip-C_OVg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:52:02 INFO - Running setup.py (path:/tmp/pip-E1MQc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:52:03 INFO - Running setup.py (path:/tmp/pip-euTrAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:52:03 INFO - Running setup.py (path:/tmp/pip-j1CkPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:52:03 INFO - Running setup.py (path:/tmp/pip-TpVrgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:52:03 INFO - Running setup.py (path:/tmp/pip-JmHHoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:52:03 INFO - Running setup.py (path:/tmp/pip-rbHHRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:52:03 INFO - Running setup.py (path:/tmp/pip-DR3REP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:03 INFO - Running setup.py (path:/tmp/pip-natbjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:52:03 INFO - Running setup.py (path:/tmp/pip-MkaLaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:52:03 INFO - Running setup.py (path:/tmp/pip-3KZBSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:52:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:52:03 INFO - Running setup.py install for manifestparser 22:52:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:52:03 INFO - Running setup.py install for mozcrash 22:52:03 INFO - Running setup.py install for mozdebug 22:52:03 INFO - Running setup.py install for mozdevice 22:52:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Running setup.py install for mozfile 22:52:04 INFO - Running setup.py install for mozhttpd 22:52:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Running setup.py install for mozinfo 22:52:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Running setup.py install for mozInstall 22:52:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Running setup.py install for mozleak 22:52:04 INFO - Running setup.py install for mozlog 22:52:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Running setup.py install for moznetwork 22:52:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:52:04 INFO - Running setup.py install for mozprocess 22:52:04 INFO - Running setup.py install for mozprofile 22:52:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:52:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:52:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:52:05 INFO - Running setup.py install for mozrunner 22:52:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:52:05 INFO - Running setup.py install for mozscreenshot 22:52:05 INFO - Running setup.py install for moztest 22:52:05 INFO - Running setup.py install for mozversion 22:52:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:52:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:52:05 INFO - Cleaning up... 22:52:05 INFO - Return code: 0 22:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:05 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 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:52:05 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 22:52:05 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 22:52:05 INFO - Using env: {'DISPLAY': ':0', 22:52:05 INFO - 'HOME': '/home/cltbld', 22:52:05 INFO - 'LANG': 'en_US.UTF-8', 22:52:05 INFO - 'LANGUAGE': 'en_US:en', 22:52:05 INFO - 'LOGNAME': 'cltbld', 22:52:05 INFO - 'MAIL': '/var/mail/cltbld', 22:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:05 INFO - 'MOZ_NO_REMOTE': '1', 22:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:05 INFO - 'NO_EM_RESTART': '1', 22:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:05 INFO - 'PWD': '/builds/slave/test', 22:52:05 INFO - 'SHELL': '/bin/bash', 22:52:05 INFO - 'SHLVL': '1', 22:52:05 INFO - 'TERM': 'linux', 22:52:05 INFO - 'TMOUT': '86400', 22:52:05 INFO - 'USER': 'cltbld', 22:52:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:05 INFO - '_': '/tools/buildbot/bin/python'} 22:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:52:05 INFO - Running setup.py (path:/tmp/pip-oVgYoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:52:05 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)) 22:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:52:05 INFO - Running setup.py (path:/tmp/pip-ZHdKIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:52:05 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)) 22:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:52:05 INFO - Running setup.py (path:/tmp/pip-gT1Fvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:52:05 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)) 22:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:52:05 INFO - Running setup.py (path:/tmp/pip-KsUwKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:52:06 INFO - Running setup.py (path:/tmp/pip-OT5tkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:52:06 INFO - Running setup.py (path:/tmp/pip-QIBRhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:52:06 INFO - Running setup.py (path:/tmp/pip-SEK_hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:52:06 INFO - Running setup.py (path:/tmp/pip-Vb5WLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:52:06 INFO - Running setup.py (path:/tmp/pip-GZFFY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:52:06 INFO - Running setup.py (path:/tmp/pip-lhlqyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:52:06 INFO - Running setup.py (path:/tmp/pip-G4B58H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:52:06 INFO - Running setup.py (path:/tmp/pip-BGxD40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:52:06 INFO - Running setup.py (path:/tmp/pip-kLFObJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:52:06 INFO - Running setup.py (path:/tmp/pip-rLcI6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:06 INFO - Running setup.py (path:/tmp/pip-EvjAtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:52:06 INFO - Running setup.py (path:/tmp/pip-CEeOTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:52:06 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)) 22:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:52:06 INFO - Running setup.py (path:/tmp/pip-TqNxHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:52:06 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)) 22:52:06 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)) 22:52:06 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)) 22:52:06 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)) 22:52:06 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)) 22:52:06 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)) 22:52:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:08 INFO - Downloading blessings-1.6.tar.gz 22:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:52:08 INFO - Installing collected packages: blessings 22:52:08 INFO - Running setup.py install for blessings 22:52:08 INFO - Successfully installed blessings 22:52:08 INFO - Cleaning up... 22:52:09 INFO - Return code: 0 22:52:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:52:09 INFO - Reading from file tmpfile_stdout 22:52:09 INFO - Current package versions: 22:52:09 INFO - argparse == 1.2.1 22:52:09 INFO - blessings == 1.6 22:52:09 INFO - blobuploader == 1.2.4 22:52:09 INFO - docopt == 0.6.1 22:52:09 INFO - manifestparser == 1.1 22:52:09 INFO - mozInstall == 1.12 22:52:09 INFO - mozcrash == 0.17 22:52:09 INFO - mozdebug == 0.1 22:52:09 INFO - mozdevice == 0.48 22:52:09 INFO - mozfile == 1.2 22:52:09 INFO - mozhttpd == 0.7 22:52:09 INFO - mozinfo == 0.9 22:52:09 INFO - mozleak == 0.1 22:52:09 INFO - mozlog == 3.1 22:52:09 INFO - moznetwork == 0.27 22:52:09 INFO - mozprocess == 0.22 22:52:09 INFO - mozprofile == 0.28 22:52:09 INFO - mozrunner == 6.11 22:52:09 INFO - mozscreenshot == 0.1 22:52:09 INFO - mozsystemmonitor == 0.0 22:52:09 INFO - moztest == 0.7 22:52:09 INFO - mozversion == 1.4 22:52:09 INFO - psutil == 3.1.1 22:52:09 INFO - requests == 1.2.3 22:52:09 INFO - wsgiref == 0.1.2 22:52:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:52:09 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')]} 22:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:09 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')]} 22:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:09 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 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:52:09 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 22:52:09 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 22:52:09 INFO - Using env: {'DISPLAY': ':0', 22:52:09 INFO - 'HOME': '/home/cltbld', 22:52:09 INFO - 'LANG': 'en_US.UTF-8', 22:52:09 INFO - 'LANGUAGE': 'en_US:en', 22:52:09 INFO - 'LOGNAME': 'cltbld', 22:52:09 INFO - 'MAIL': '/var/mail/cltbld', 22:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:09 INFO - 'MOZ_NO_REMOTE': '1', 22:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:09 INFO - 'NO_EM_RESTART': '1', 22:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:09 INFO - 'PWD': '/builds/slave/test', 22:52:09 INFO - 'SHELL': '/bin/bash', 22:52:09 INFO - 'SHLVL': '1', 22:52:09 INFO - 'TERM': 'linux', 22:52:09 INFO - 'TMOUT': '86400', 22:52:09 INFO - 'USER': 'cltbld', 22:52:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:09 INFO - '_': '/tools/buildbot/bin/python'} 22:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 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)) 22:52:09 INFO - Cleaning up... 22:52:09 INFO - Return code: 0 22:52:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:52:09 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')]} 22:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:09 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')]} 22:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:09 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 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:52:09 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 22:52:09 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 22:52:09 INFO - Using env: {'DISPLAY': ':0', 22:52:09 INFO - 'HOME': '/home/cltbld', 22:52:09 INFO - 'LANG': 'en_US.UTF-8', 22:52:09 INFO - 'LANGUAGE': 'en_US:en', 22:52:09 INFO - 'LOGNAME': 'cltbld', 22:52:09 INFO - 'MAIL': '/var/mail/cltbld', 22:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:09 INFO - 'MOZ_NO_REMOTE': '1', 22:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:09 INFO - 'NO_EM_RESTART': '1', 22:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:09 INFO - 'PWD': '/builds/slave/test', 22:52:09 INFO - 'SHELL': '/bin/bash', 22:52:09 INFO - 'SHLVL': '1', 22:52:09 INFO - 'TERM': 'linux', 22:52:09 INFO - 'TMOUT': '86400', 22:52:09 INFO - 'USER': 'cltbld', 22:52:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:09 INFO - '_': '/tools/buildbot/bin/python'} 22:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:09 INFO - Downloading/unpacking jsonschema 22:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:52:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22:52:11 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 22:52:11 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 22:52:11 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 22:52:11 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 22:52:11 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 22:52:11 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 22:52:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:52:11 INFO - warning: no files found matching '*.txt' 22:52:11 INFO - no previously-included directories found matching 'build' 22:52:11 INFO - no previously-included directories found matching 'dist' 22:52:11 INFO - no previously-included directories found matching '.git*' 22:52:11 INFO - Installing collected packages: jsonschema, functools32 22:52:11 INFO - Running setup.py install for functools32 22:52:11 INFO - warning: no files found matching '*.txt' 22:52:11 INFO - no previously-included directories found matching 'build' 22:52:11 INFO - no previously-included directories found matching 'dist' 22:52:11 INFO - no previously-included directories found matching '.git*' 22:52:11 INFO - Successfully installed jsonschema functools32 22:52:11 INFO - Cleaning up... 22:52:12 INFO - Return code: 0 22:52:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1826dbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', '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 22:52:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:52:12 INFO - Using env: {'DISPLAY': ':0', 22:52:12 INFO - 'HOME': '/home/cltbld', 22:52:12 INFO - 'LANG': 'en_US.UTF-8', 22:52:12 INFO - 'LANGUAGE': 'en_US:en', 22:52:12 INFO - 'LOGNAME': 'cltbld', 22:52:12 INFO - 'MAIL': '/var/mail/cltbld', 22:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:12 INFO - 'MOZ_NO_REMOTE': '1', 22:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:12 INFO - 'NO_EM_RESTART': '1', 22:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:12 INFO - 'PWD': '/builds/slave/test', 22:52:12 INFO - 'SHELL': '/bin/bash', 22:52:12 INFO - 'SHLVL': '1', 22:52:12 INFO - 'TERM': 'linux', 22:52:12 INFO - 'TMOUT': '86400', 22:52:12 INFO - 'USER': 'cltbld', 22:52:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:12 INFO - '_': '/tools/buildbot/bin/python'} 22:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:12 INFO - Downloading/unpacking flake8 22:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:52:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:52:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:52:14 INFO - no previously-included directories found matching 'docs/_build' 22:52:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:52:14 INFO - Running setup.py install for pep8 22:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:52:14 INFO - no previously-included directories found matching 'docs/_build' 22:52:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:52:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:52:15 INFO - Cleaning up... 22:52:15 INFO - Return code: 0 22:52:15 INFO - Running post-action listener: _resource_record_post_action 22:52:15 INFO - Running post-action listener: _start_resource_monitoring 22:52:15 INFO - Starting resource monitoring. 22:52:15 INFO - ##### 22:52:15 INFO - ##### Running install step. 22:52:15 INFO - ##### 22:52:15 INFO - Running pre-action listener: _resource_record_pre_action 22:52:15 INFO - Running main action method: install 22:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:52:15 INFO - Reading from file tmpfile_stdout 22:52:15 INFO - Detecting whether we're running mozinstall >=1.0... 22:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:52:15 INFO - Reading from file tmpfile_stdout 22:52:15 INFO - Output received: 22:52:15 INFO - Usage: mozinstall [options] installer 22:52:15 INFO - Options: 22:52:15 INFO - -h, --help show this help message and exit 22:52:15 INFO - -d DEST, --destination=DEST 22:52:15 INFO - Directory to install application into. [default: 22:52:15 INFO - "/builds/slave/test"] 22:52:15 INFO - --app=APP Application being installed. [default: firefox] 22:52:15 INFO - mkdir: /builds/slave/test/build/application 22:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:52:30 INFO - Reading from file tmpfile_stdout 22:52:30 INFO - Output received: 22:52:30 INFO - /builds/slave/test/build/application/firefox/firefox 22:52:30 INFO - Running post-action listener: _resource_record_post_action 22:52:30 INFO - ##### 22:52:30 INFO - ##### Running run-tests step. 22:52:30 INFO - ##### 22:52:30 INFO - Running pre-action listener: _resource_record_pre_action 22:52:30 INFO - Running main action method: run_tests 22:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:52:30 INFO - Python 2.7.3 22:52:30 INFO - Return code: 0 22:52:30 INFO - grabbing minidump binary from tooltool 22:52:30 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')]} 22:52:30 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 0x14ea160>, '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 0x14eb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eb4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:52:30 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 22:52:30 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 22:52:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:52:30 INFO - Return code: 0 22:52:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:52:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:52:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:52:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:52:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:52:31 INFO - Return code: 0 22:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 22:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 22:52:31 INFO - Using env: {'DISPLAY': ':0', 22:52:31 INFO - 'HOME': '/home/cltbld', 22:52:31 INFO - 'LANG': 'en_US.UTF-8', 22:52:31 INFO - 'LANGUAGE': 'en_US:en', 22:52:31 INFO - 'LOGNAME': 'cltbld', 22:52:31 INFO - 'MAIL': '/var/mail/cltbld', 22:52:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:52:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:31 INFO - 'MOZ_NO_REMOTE': '1', 22:52:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:31 INFO - 'NO_EM_RESTART': '1', 22:52:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:31 INFO - 'PWD': '/builds/slave/test', 22:52:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:52:31 INFO - 'SHELL': '/bin/bash', 22:52:31 INFO - 'SHLVL': '1', 22:52:31 INFO - 'TERM': 'linux', 22:52:31 INFO - 'TMOUT': '86400', 22:52:31 INFO - 'USER': 'cltbld', 22:52:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538', 22:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:31 INFO - '_': '/tools/buildbot/bin/python'} 22:52:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 22:52:31 INFO - mozversion application_buildid: 20160423200744 22:52:31 INFO - mozversion application_changeset: 2b7291cc565421eebd5328f09dede6ff40ce0b42 22:52:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:52:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:52:31 INFO - mozversion application_name: Firefox 22:52:31 INFO - mozversion application_remotingname: firefox-dev 22:52:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:52:31 INFO - mozversion application_vendor: Mozilla 22:52:31 INFO - mozversion application_version: 47.0a2 22:52:31 INFO - mozversion platform_buildid: 20160423200744 22:52:31 INFO - mozversion platform_changeset: 2b7291cc565421eebd5328f09dede6ff40ce0b42 22:52:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:52:31 INFO - mozversion platform_version: 47.0a2 22:52:31 INFO - using testdate: 1461477151 22:52:31 INFO - actual date: 1461477151 22:52:31 INFO - starting webserver on 'localhost:46443' 22:52:31 INFO - SUITE-START | Running 2 tests 22:52:31 INFO - TEST-START | dromaeo_css 22:52:31 INFO - operating with platform_type : linux_ 22:52:31 INFO - Initialising browser for dromaeo_css test... 22:52:31 INFO - TEST-INFO | started process 5000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQnYYCB/profile http://localhost:46443/getInfo.html) 22:52:36 INFO - PROCESS | 5000 | __metrics Screen width/height:1600/1200 22:52:36 INFO - PROCESS | 5000 | colorDepth:24 22:52:36 INFO - PROCESS | 5000 | Browser inner width/height: 1024/697 22:52:36 INFO - PROCESS | 5000 | __metrics 22:52:37 INFO - PROCESS | 5000 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:52:38 INFO - TEST-INFO | 5000: exit 0 22:52:38 INFO - Browser initialized. 22:52:38 INFO - Running cycle 1/1 for dromaeo_css test... 22:52:38 INFO - TEST-INFO | started process 5089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQnYYCB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:50 INFO - PROCESS | 5089 | RSS: Main: 141488128 22:52:50 INFO - PROCESS | 5089 | 22:53:42 INFO - PROCESS | 5089 | 1461477222064 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] 22:55:49 INFO - PROCESS | 5089 | Cycle 1(1): loaded http://localhost:46443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46443/tests/dromaeo/cssquery-ext.html) 22:55:50 INFO - PROCESS | 5089 | RSS: Main: 217534464 22:55:50 INFO - PROCESS | 5089 | 22:58:52 INFO - PROCESS | 5089 | Cycle 1(1): loaded http://localhost:46443/tests/dromaeo/cssquery-ext.html (next: http://localhost:46443/tests/dromaeo/cssquery-jquery.html) 22:58:52 INFO - PROCESS | 5089 | RSS: Main: 221630464 22:58:52 INFO - PROCESS | 5089 | 23:01:54 INFO - PROCESS | 5089 | Cycle 1(1): loaded http://localhost:46443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46443/tests/dromaeo/cssquery-mootools.html) 23:01:55 INFO - PROCESS | 5089 | RSS: Main: 231309312 23:01:55 INFO - PROCESS | 5089 | 23:04:57 INFO - PROCESS | 5089 | Cycle 1(1): loaded http://localhost:46443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46443/tests/dromaeo/cssquery-prototype.html) 23:04:57 INFO - PROCESS | 5089 | RSS: Main: 193982464 23:04:57 INFO - PROCESS | 5089 | 23:08:00 INFO - PROCESS | 5089 | Cycle 1(1): loaded http://localhost:46443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46443/tests/dromaeo/cssquery-yui.html) 23:08:00 INFO - PROCESS | 5089 | RSS: Main: 202346496 23:08:00 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | Cycle 1(1): loaded http://localhost:46443/tests/dromaeo/cssquery-yui.html (next: http://localhost:46443/tests/dromaeo/cssquery-dojo.html) 23:11:03 INFO - PROCESS | 5089 | RSS: Main: 252252160 23:11:03 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | __start_tp_report 23:11:03 INFO - PROCESS | 5089 | _x_x_mozilla_page_load 23:11:03 INFO - PROCESS | 5089 | _x_x_mozilla_page_load_details 23:11:03 INFO - PROCESS | 5089 | |i|pagename|runs| 23:11:03 INFO - PROCESS | 5089 | |0;dojo.html;3265.591801024872;3302.306515631717;3316.718078963288;3320.2031512437025;3347.8995630131103;5294.57643388529;5317.175837745151;5323.680579165253;5344.971362658107;5374.328208973879;5316.574674026078;5347.144456886899;5349.545288650469;5367.731613419333;5375.784968601261;4824.903501929959;4923.212286034235;4937.530934561229;4991.176455884774;5015.673981191229;4854.12625727369;4878.146324393235;4937.728424936627;4945.950540494585;4948.703077815325;4935.679180853233;5011.749412529377;5031.949680503185;5033.320501732274;5063.088644044071;4917.041176970492;4947.876303092416;4953.678010929278;4970.751462426882;4983.875403114915;4797.688150270221;4944.53026962438;4955.801767929279;4991.07665081961;5001.674891132101;5250.737463126867;5310.654807437504;5317.9468205317835;5330.440303768126;5347.144456886879;5719.428057194289;5722;5729.598928075036;5730.312362516524;5736;5679.829605111812;5711.029125048752;5730.226419433365;5757.539396848242;5768.42315768424;5458.563314934835;5468.535174510172;5472.589555783293;5473.397926228112;5498.3127109111365;5951.5238780897425;5955.076963070731;5955.225820643289;5959.970200148971;5961.5230781537375;5526.088195447786;5689.231953686282;5690.459406356389;5708.457696518824;5791.913121303184;5839.824805255849;5843.211166492554;5843.795467158714;5844.386339434298;5845.970770146122;5765.913511297334;5783.248177736868;5787.826365209051;5789.131630255495;5790;5650.858728531737;5712.171735098387;5774.04728219839;5791.362950075489;5799.420057994167;4390.780460976938;4392.3191905254735;4393.275109606943;4394.978025109854;4410.536893626123;3966.167104907944;3971.900702482403;3973.7615743055508;3983.64147226751;3993.3011722948368;5329.094054010828;5476.479734425223;5545.611807173459;5554.583406244547;5567.359753628303;5763.423657634287;5798;5807.361190269067;5814.476697097281;5826.359100498942;5298.125809241509;5438.374586922555;5481.835544933659;5492.231087647732;5502.532284755841;4911.16510193268;4968.453470118284;4971.403431588233;4982.77577509013;5010.198368261061;5901.822945311647;5957.940420595825;5960.403959604092;5963.0459126539545;5970.940290597038;5636.887262254814;5743.483086522233;5800.912986305125;5802.071668533099;5823.912641310299;5933.080372542263;5975.880482390415;5984.311804142405;5988.161657368059;6016.4885984690045;5731.197632331394;5758.568107391879;5768.826935191951;5770.624909381045;5784.479396854135;5669.773209071756;5797.768089276382;5802.970985145047;5832.066869301061;5889.823305300848;5600.915986260291;5602.3837377887585;5603.719814009201;5604.495595396434;5611.5230205433;5573.916391254215;5592.105263157875;5600.243967064557;5603.747831347518;5613.24221230145;5337.893242135213;5510.972445137749;5597.272354593877;5654.6889921054735;5682.687452190169;5545.972270138785;5630.493255607015;5682.801101961411;5706.172604972338;5731.140328950691;5587.441255874543;5597.44025597437;5606.103023516218;5615.2700148980375;5618.195859594961 23:11:03 INFO - PROCESS | 5089 | |1;ext.html;576.3659974028567;584.6550535184241;633.8922383194856;639.5267502048484;642.5855323316464;32113;40510.1897962041;41026.58973410265;41052.58947410525;41107.383389249146;44262.336064958974;44804.55195448045;44851;45044.774776126156;45138.32292515607;8038.839223215561;8181.79545511361;8906;9120.543972801366;10487.056164945154;10564.683059508188;10668.519916603733;10714.732131696692;10736.24846260762;10737.624183153592;10671.19966002549;10756.085732712729;10768.192385571074;10769.78460430791;10780.676579702582;10659.946700266488;10701.143908487302;10717.571297148104;10744.30162039465;10752.139828813677;10602.946985265024;10693.78612427747;10711.785764284748;10713.517891694892;11028.117750579935;44601.77699111516;45056.774716126536;45063.54936450626;45129.54870451286;45180.09639807185;3530.258645684409;3620.6741393274733;3649.835757390924;3672.338978983782;3771.547414310273;31473.842630786927;33202.50196247058;33315.6668433315;33574.83212583946;34043.31913361719;3829.3872980323295;3829.5213098362706;3985.262726395597;3987.641112299878;3988.760674359548;302711;303128;304089;305701;306088;45292.773536132765;45983;46039;67611.66194169097;68113;44037.559624403984;44110.55889441064;44235.77882110633;44350.778246108566;44504.3324350135;14384.424623014962;14392.280385980659;14404;14439;14922.925385373004;13115.803262951064;13265.403056862464;13298.534551290659;13333.799993000113;13345;15857.524274271791;15937.601559961095;15937.920310398375;15945.601359966093;16040.358385664442;5691.601587888808;5709.714514274269;5736.110902810071;5747.770089196469;5962.761489540457;961.4663861556903;1022.9232807539315;1034.3018462537757;1072.254782925859;1099.1701265544464;29897.701022989928;30084.398312033638;30433.391332173676;30803.383932321227;31024.22439438987;1149.7010777197822;1174.512577280436;1226.5707002549216;1242.937853107341;1247.7379750252367;15556.688866222612;15743.974808045952;15823.920880395524;15840;15968.201589920458;336113;341435;342716;342894;343562;58446.41553584495;59594;59654.701726491956;59672.40327596669;59715.61137554449;1268.3341245846004;1375.8968077394236;1448.4133925760084;1473.62422582243;1517.1352329172487;27881.581776272968;28671.71328286774;29838;30632.540511892785;30670.233244169074;48385.27422088601;48803.75598121987;48985.265221021;49041;49061.75469122631;204626;205589;205594;206393;206950;31027;34763.826180868935;35149.47275790916;35240.64759352374;35794.10514737153;56615.43384566101;56986;57400;58011.41988580229;58158.70920645539;39422.211555769296;39642.60357396389;40498.39252411275;40634;40639;40560.39159412552;42581.78709106435;42940.35589466098;43636.78181609072;44243;43478.39120659506;43531.34702979394;43705.56294437015;43958.340624891294;44211.55788442203;38249.426258605585;39674.801625991684;39747.40378894377;39904.40143397793;40397;29555.261118472212;29573.112806615834;29977.850110749307;30049;30230.54654180233 23:11:03 INFO - PROCESS | 5089 | |2;jquery.html;378.07937671769224;379.55023297392586;383.7850803550011;385.62594283544985;388.4639197906888;17754.378596749117;18626;19026.287634112927;19287.421377358667;19362.90318548407;12465.065120116005;12840.165389249692;12844.550440734576;12857.871421285785;12861.614151575468;4081.3061779497557;5170.612204084689;5279.5512381447625;5828.504577110951;5836.182934389189;4157.355609880473;5506.834794956158;5710.257666503348;5715.171300161474;5720.084786434171;5519.199716041172;5683.715814209273;5694;5698.059820129673;5698.886022279552;5823.3012038555435;5832.300123985149;5859.824205273849;5868.3838196989345;5868.706564671771;5484.506394424521;5646.858828529279;5648.209250704905;5649.378568357477;5651.604387692863;21879.562408751735;22021.559568808694;22221.555568888693;22245.332640020824;22249.332520024425;2096.6645336746046;2182.2689399051337;2313.4679023824615;2523.7602427769334;2783.2902609834364;10223.437710925897;10342.896571034269;10559.841602375971;10677.83983240252;10876;1916.1856211110223;1934;1969.3008981811395;1984.5237143085699;1995;68458.65770671115;70152;70542.29457705408;71004;72068.27931720667;10330.380177189392;10576.41829699374;10728.620484547499;10783.29908555957;10856.945715271373;15217.31522081509;15469.767953480707;15549.455769048029;15561.221938903009;15574.065556066445;7716.382689384835;7877.7636670899965;7940.0868900076075;8001.399895007898;8055.63749631268;7707.614619269014;7746.806329841799;7764.184760600168;7770.417218708506;7812.218778122142;4605;4688.976555117202;4750.097481478508;4762.738049407316;4797.136515427187;1813.5375479252707;1896.9905150474435;1941.9417417477498;1980.4454752669276;1984.8015198480325;922.3727865051695;970.6505657963128;983.4154506822591;1002.3935519010894;1016.5730393234859;16014.919925400298;16498.917505412635;16597.419090332023;16868.29969455579;17339.306427743002;961.6682244625594;975.7755716185175;977.2084611464736;991.7520619845038;1018.5671089786811;9763.804723905481;9933;9958.452285124387;9993.374943338336;10144.847827282596;465818;468648;475133;476196;479737;81254.59372703217;81473.18526814775;81525.59237203776;81716.18283817204;83107;1050.1808589300206;1073.4471747050275;1074.5164675895878;1075.064693716456;1091.5961094394966;16054.839451605334;16284.267207975432;16303.755443668117;16359.509214723577;16534.09062501574;22830.200942966916;35749.1062723434;36430;36625.26749465049;36697.44953825748;49891;52242.738786305825;52553.7372313136;52558;52560;7810.531368117931;7909.209079092045;8025.23760242776;8036.557989310644;8064.032316122103;9068.818623627358;11764.235324703866;11800.114991375509;11935.52257909674;12288.692782680504;10181.69505703802;10246.129079028366;10643.201759867887;10796.406197659204;11064.944675276573;10178.13485853681;10303.3817970922;10323.690289291333;10360.274780765274;10385.584576616851;10449.16406687448;10709;10873.07578855806;11054.834177487504;11109.722256943642;8009.959950200212;8034.83930321402;8038.437309388287;8126.75619731409;8322;10067.546960386946;10114.747131321776;10276.537555810157;10284.742881428025;10285.382877027403 23:11:03 INFO - PROCESS | 5089 | |3;mootools.html;1472.7569950958093;1584.920753962302;1606.3895719626544;1838.5863180784324;1981.8315443187328;8225.794355141124;8431.873521897176;8439.62021709023;8447.493150410979;8451.746447606567;8460.450070745412;8625.568721563928;8628.137186281385;8637.438566493189;8639.913600863989;2181.4982554012586;2461.8645974471397;2508.611165269386;2522.3063657494154;2541.0852093246417;2486.0304481252324;2503.8998440062373;2513.673222481084;2516.094206085808;2518.3955850595908;2495.800335973118;2511.962320565193;2513.3716570857287;2514.88683009265;2515.584928486807;2431.683881095455;2508.046942161985;2508.297676650541;2508.5108403861254;2513.082724805451;2464.6795916530737;2491.402063504764;2503.086373473687;2507.6489291499206;2508.3854455658297;8606.526641034741;8639.956800216021;8666.090060543615;8671.349648776304;8680.565971701453;5368.463153684639;5487.64330318528;5534.142207957773;5543.916841247385;5544.029794785896;3202.647708752035;3236.255661197914;3256.462683657194;3257.2996805686653;3282.688144626257;979.5200351827554;988.0860204310984;991.7371896447447;997.3467378866853;1029.3772267778036;12452;12495.312757798318;12499.437525311383;12509.687257818627;12511;4823.614110871122;4836.975815120973;4902.558769710672;4910.48439913811;4926.531979461945;10400.739981500372;10421.53103110362;10422.947885260524;10430.322029068086;10431.634892778717;4897.730624815598;5481.013417584793;5521.061419558685;5524.1989911462615;5527.309086364205;4824.565789079;4851.902961940741;4903;4909.214525675875;4913.950860491421;4005.719599627998;4051.311277082903;4088.7546747195265;4104.076582768913;4108.6918481114035;1313.356455336878;1335.8978842455012;1338.4110991164052;1342.1276170489066;1349.156777014366;1403.7964495148146;1477.30566633682;1490.6496973211288;1500.5648361975122;1519.8100237470317;8169.79575510617;8271;8337.95775528059;8346.789715491219;8351.331893448509;1175.6590588729343;1189;1219.7987332090106;1251.2742609286593;1278.3991523983898;6405.391487808651;6431.614103153825;6476.579022363531;6510.414062734282;6522.706478208492;10279.743006424898;10744.677659670222;10765.946170269099;10783.29908555957;10905.182111341523;10570.947145264225;10651.84022239667;10892.292001019909;10920.726981825359;10972.506237219344;8402.243798058204;8474.449160804528;8554.486730796172;8554.871676924851;8567.357448191411;7865.567393793396;8046.316063134699;8064.435489515678;8107.756767296991;8115.51306921563;9093.954530227307;9213.58538865766;9271.30465215098;9523.666671666459;9543.093406126407;9446.29152813528;9557.904420955701;9559.522023898917;9782.021797820445;9783.461909594756;6989.30106989297;7010.789676309719;7939.404544659058;8070.596470176585;8077.676892924217;8219.95890020546;8237.670493180205;8272.33821294307;8276.420650554644;8284.792880178044;7253.310935461122;7407.962960185165;7501.662425190989;7526.849463010819;7683.692652293846;7402.703891844266;7417.592032438268;7426;7550.735724249625;7578.924210757822;7731.536107833323;7812.218778122142;7817.765467035998;7855.293023627901;7865.764027079197;6925.861482770417;6994.125734283215;7036;7059.329363710439;7081.433485321265;7329.303716146957;7399.889001665087;7461.962690186514;7468.738594149178;7474.887876681745 23:11:03 INFO - PROCESS | 5089 | |4;prototype.html;366.06470467954375;366.93395188866026;367.73523063394344;372.2647770652961;380.56235329371236;5984.132300816379;6009.4591486766185;6016.5788394812325;6028.547858910577;6042.788502402417;5958.731857066432;5966.045432730764;5971;5975.701214939258;5981.611195272304;4512.165249428866;4612.331211974261;4727.905441891177;4742.336072949781;4751.3585665935;4731.172044892147;4751.857444276678;4753.524647535236;4755.334253204537;4755.571998520132;4716.339712440261;4716.481187069419;4729.739864307462;4731.408573928259;4733.786979585927;4446.3108218226225;4572.885677858064;4640.79116439761;4655.604273636745;4667.416572928384;4155.8753237402925;4205.621494065518;4216;4217.915641687149;4219.683523735732;5738.254026976508;5740.425957404268;5741.770329186869;5755.280589926259;5766.04860198071;5516.613837031409;5518.779248830042;5519.668819870821;5523.861903452445;5526.944730552683;6315.336889626569;6335.493160547145;6346.6509341986175;6348.301686814447;6366.649834259114;4390.978045109786;4524.502304746476;4533.795979180912;4537.931931021038;4674.579287864109;6580.341965803429;6644.169478815148;6659.03444000622;6660;6661.766838160641;4663.813447462131;4664.65015123867;4664.906701865943;4666.673332866667;4667.206574882278;4735.384400028043;4739.2891066339635;4742.170120228946;4743.407074115736;4743.976280118577;5403.405625381205;5414.593905457106;5416.566674666017;5418.620696551204;5419.566434685295;6313.116163737081;6438.645874476855;6447.097406363113;6449.774257900951;6458.2895881453005;1647.184643601401;1659.5104444188994;1667.924943377551;1668.6329007618303;1669.4741156535651;1017.9389236645825;1089.4498278369372;1096.6456426313496;1110.622388387952;1135.3585224348217;6154;6157.168782214433;6159.96920015406;6168.753249870045;6174.043023331391;6535.771248006392;6539.738410463528;6540.738370465128;6555.3772391622715;6557.901631475532;6153.2000839890525;6157.507399408037;6158;6158.568900176944;6170.074488826622;3481.4951831984727;3513.350030244413;3518.7185025197923;3520.9295814083575;3524.101354154674;6590.670466476657;6698.765543205965;6756.121704178426;6756.2568117507035;6758.966205169041;6697.497687673444;6701.765438209639;6703.3296670332575;6710.328967103348;6712.060311556386;6723.798286051328;6731.562448440835;6737.225219099768;6739.865202695919;6742.123523941954;6504.089427480251;6506.284308726131;6507.056476810931;6511.772087976898;6521.934780652133;6367.713452894538;6421.197350331208;6441.774537891151;6485.805425837232;6598.208215014229;6842.24735279109;6869.725210991504;6886.586804791728;6888.655567221719;6899.275576064441;4793.640476964311;4847.587955023721;4851.805927762991;4858.319835223001;4859.343988561499;6610.206775187008;6614.4708423325055;6618;6622.503312251697;6623.3376662333385;6109.480694141048;6308.053791931247;6414.069959855701;6416.294207637063;6419.197600299963;6312.116303717391;6451.838704032437;6477.4170324671;6482.643454610042;6484.481241500763;6344.619322840645;6354.93645063562;6357.777477788441;6361.491080713625;6368.395002474757;6486.9351306488215;6500.934990650033;6508.8047358579315;6516.902246466212;6518.57629254097;6143.232095988002;6308.400701933309;6353.618782873043;6355.618662880242;6390.329015453311 23:11:03 INFO - PROCESS | 5089 | |5;yui.html;787.8030492376906;798.2257210505808;812.480012791813;865.545588566003;882.2236431939892;12916.289604071771;13079.60761177165;13085.21488710678;13114.278714670689;13136.934315328434;12289.139760216765;12308.876911230886;12316.692082697937;12350.135490515668;12361.258324500537;758.0751483190527;876.0801158783252;886.1404437695458;891.9331050171247;895.5790778334173;890.3366991591273;901.324006994754;901.432097778402;901.486152892848;902.5171533229724;945.0927109974433;950.6435086842434;950.8906475755308;951.3245595627078;952.2049089010684;788.1921030943272;938.2212763406391;959.7552624080885;960.9951950240204;961.2310151878469;714.2678754276856;714.3071220915704;714.9106361704787;715.2382712411265;715.7316006497564;12823.102382833205;12929.224246545238;12968.221906685534;13002.674933126653;13003.154794938393;12917.224966501946;13577;13903.930480347635;14245.78631320531;14286.499972501017;11395.316281023164;11441.599544015919;11597.884021159765;11736.765264694659;11878.524859005629;3788.9431658525145;3815.7468139760967;3870.4774855394444;3937.9212415751813;3965.286248475273;51777;52936;54612;54755.452445475836;54999.72500137514;10794.298370605886;11068.225224234226;11263.324200547993;11348.432578371214;11378.374189419661;18650.16074276661;18700.532486687942;18701.719474207897;18712;18788.436346909613;8346.374021948379;8371.706990255312;8475.788105297417;8526.147385261549;8551.871721924175;4434.866953991385;4518.390017347681;4525.456945166601;4636.397268355092;4693.108309421199;3389.1527118220447;3430.142464383904;3435.862565497402;3452.7065199457825;3453.3611281912927;590.4597293476506;621.9813405597839;624.2664868779257;631.6462780842743;678.4131726057024;608.397686290578;646.2116218213772;683.8085336105898;684.7466437418187;698.8043347862607;7737.535747855147;7873.606319683993;7965.123836377994;8004.439689221698;8073.748568971819;526.3525863188299;613.3375953969702;634.7746549974785;654.7446495866616;674.275154209227;3765.6987441004653;3786.8106594670708;3789;3797.316483033025;3851.30676478231;58060.41939580635;58303.41696583065;58794.35425405867;59185.70407148023;59608.40391596028;49167;49682.75158624256;50126.74936625294;50415.243771343456;51237;48392.758036210296;48512.27231591529;49060.75469622629;49320.506794932306;49453;8214.3428525719;8357.498550087013;8379.120192379713;8383.874241886255;8467.61895714682;35235;35692.10769730777;36028;37164.25671486609;37466.43800342942;39100;39587.80206098951;44737;44763.32855007112;44921.55078449305;11309.604163854226;11813.527458901548;12085.516579336729;12340.753184936071;12845.614631561068;11834.940825295818;11855.466504007512;11907.285562866256;11983.64049078529;12062.457189426672;11177.944110279397;11193.216474846682;11411.657650270505;11629.659000793155;11901.821472677744;10814.675559733221;10958.178136639624;11177.217594768288;11524.308541487537;11764.823527647264;11008.614698485515;11202.159838012345;11307.095432365226;11419.31484110956;11521.423928803693;9365.082533282595;9366.110219529133;9642;9731;9764.365316254421;9442;9496.905030949878;9608.615655373707;9721.027897210222;9882.160016398399 23:11:03 INFO - PROCESS | 5089 | __end_tp_report 23:11:03 INFO - PROCESS | 5089 | __start_cc_report 23:11:03 INFO - PROCESS | 5089 | _x_x_mozilla_cycle_collect,687 23:11:03 INFO - PROCESS | 5089 | __end_cc_report 23:11:03 INFO - PROCESS | 5089 | __startTimestamp1461478263323__endTimestamp 23:11:03 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | ------- Summary: start ------- 23:11:03 INFO - PROCESS | 5089 | Number of tests: 6 23:11:03 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | [#0] dojo.html Cycles:165 Average:5374.61 Median:5597.27 stddev:583.85 (10.4%) stddev-sans-first:561.71 23:11:03 INFO - PROCESS | 5089 | Values: 3265.6 3302.3 3316.7 3320.2 3347.9 5294.6 5317.2 5323.7 5345.0 5374.3 5316.6 5347.1 5349.5 5367.7 5375.8 4824.9 4923.2 4937.5 4991.2 5015.7 4854.1 4878.1 4937.7 4946.0 4948.7 4935.7 5011.7 5031.9 5033.3 5063.1 4917.0 4947.9 4953.7 4970.8 4983.9 4797.7 4944.5 4955.8 4991.1 5001.7 5250.7 5310.7 5317.9 5330.4 5347.1 5719.4 5722.0 5729.6 5730.3 5736.0 5679.8 5711.0 5730.2 5757.5 5768.4 5458.6 5468.5 5472.6 5473.4 5498.3 5951.5 5955.1 5955.2 5960.0 5961.5 5526.1 5689.2 5690.5 5708.5 5791.9 5839.8 5843.2 5843.8 5844.4 5846.0 5765.9 5783.2 5787.8 5789.1 5790.0 5650.9 5712.2 5774.0 5791.4 5799.4 4390.8 4392.3 4393.3 4395.0 4410.5 3966.2 3971.9 3973.8 3983.6 3993.3 5329.1 5476.5 5545.6 5554.6 5567.4 5763.4 5798.0 5807.4 5814.5 5826.4 5298.1 5438.4 5481.8 5492.2 5502.5 4911.2 4968.5 4971.4 4982.8 5010.2 5901.8 5957.9 5960.4 5963.0 5970.9 5636.9 5743.5 5800.9 5802.1 5823.9 5933.1 5975.9 5984.3 5988.2 6016.5 5731.2 5758.6 5768.8 5770.6 5784.5 5669.8 5797.8 5803.0 5832.1 5889.8 5600.9 5602.4 5603.7 5604.5 5611.5 5573.9 5592.1 5600.2 5603.7 5613.2 5337.9 5511.0 5597.3 5654.7 5682.7 5546.0 5630.5 5682.8 5706.2 5731.1 5587.4 5597.4 5606.1 5615.3 5618.2 23:11:03 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | [#1] ext.html Cycles:180 Average:47159.96 Median:343228.00 stddev:75618.76 (22.0%) stddev-sans-first:75750.00 23:11:03 INFO - PROCESS | 5089 | Values: 576.4 584.7 633.9 639.5 642.6 32113.0 40510.2 41026.6 41052.6 41107.4 44262.3 44804.6 44851.0 45044.8 45138.3 8038.8 8181.8 8906.0 9120.5 10487.1 10564.7 10668.5 10714.7 10736.2 10737.6 10671.2 10756.1 10768.2 10769.8 10780.7 10659.9 10701.1 10717.6 10744.3 10752.1 10602.9 10693.8 10711.8 10713.5 11028.1 44601.8 45056.8 45063.5 45129.5 45180.1 3530.3 3620.7 3649.8 3672.3 3771.5 31473.8 33202.5 33315.7 33574.8 34043.3 3829.4 3829.5 3985.3 3987.6 3988.8 302711.0 303128.0 304089.0 305701.0 306088.0 45292.8 45983.0 46039.0 67611.7 68113.0 44037.6 44110.6 44235.8 44350.8 44504.3 14384.4 14392.3 14404.0 14439.0 14922.9 13115.8 13265.4 13298.5 13333.8 13345.0 15857.5 15937.6 15937.9 15945.6 16040.4 5691.6 5709.7 5736.1 5747.8 5962.8 961.5 1022.9 1034.3 1072.3 1099.2 29897.7 30084.4 30433.4 30803.4 31024.2 1149.7 1174.5 1226.6 1242.9 1247.7 15556.7 15744.0 15823.9 15840.0 15968.2 336113.0 341435.0 342716.0 342894.0 343562.0 58446.4 59594.0 59654.7 59672.4 59715.6 1268.3 1375.9 1448.4 1473.6 1517.1 27881.6 28671.7 29838.0 30632.5 30670.2 48385.3 48803.8 48985.3 49041.0 49061.8 204626.0 205589.0 205594.0 206393.0 206950.0 31027.0 34763.8 35149.5 35240.6 35794.1 56615.4 56986.0 57400.0 58011.4 58158.7 39422.2 39642.6 40498.4 40634.0 40639.0 40560.4 42581.8 42940.4 43636.8 44243.0 43478.4 43531.3 43705.6 43958.3 44211.6 38249.4 39674.8 39747.4 39904.4 40397.0 29555.3 29573.1 29977.9 30049.0 30230.5 23:11:03 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | [#2] jquery.html Cycles:180 Average:26986.00 Median:36527.63 stddev:77728.15 (212.8%) stddev-sans-first:77920.52 23:11:03 INFO - PROCESS | 5089 | Values: 378.1 379.6 383.8 385.6 388.5 17754.4 18626.0 19026.3 19287.4 19362.9 12465.1 12840.2 12844.6 12857.9 12861.6 4081.3 5170.6 5279.6 5828.5 5836.2 4157.4 5506.8 5710.3 5715.2 5720.1 5519.2 5683.7 5694.0 5698.1 5698.9 5823.3 5832.3 5859.8 5868.4 5868.7 5484.5 5646.9 5648.2 5649.4 5651.6 21879.6 22021.6 22221.6 22245.3 22249.3 2096.7 2182.3 2313.5 2523.8 2783.3 10223.4 10342.9 10559.8 10677.8 10876.0 1916.2 1934.0 1969.3 1984.5 1995.0 68458.7 70152.0 70542.3 71004.0 72068.3 10330.4 10576.4 10728.6 10783.3 10856.9 15217.3 15469.8 15549.5 15561.2 15574.1 7716.4 7877.8 7940.1 8001.4 8055.6 7707.6 7746.8 7764.2 7770.4 7812.2 4605.0 4689.0 4750.1 4762.7 4797.1 1813.5 1897.0 1941.9 1980.4 1984.8 922.4 970.7 983.4 1002.4 1016.6 16014.9 16498.9 16597.4 16868.3 17339.3 961.7 975.8 977.2 991.8 1018.6 9763.8 9933.0 9958.5 9993.4 10144.8 465818.0 468648.0 475133.0 476196.0 479737.0 81254.6 81473.2 81525.6 81716.2 83107.0 1050.2 1073.4 1074.5 1075.1 1091.6 16054.8 16284.3 16303.8 16359.5 16534.1 22830.2 35749.1 36430.0 36625.3 36697.4 49891.0 52242.7 52553.7 52558.0 52560.0 7810.5 7909.2 8025.2 8036.6 8064.0 9068.8 11764.2 11800.1 11935.5 12288.7 10181.7 10246.1 10643.2 10796.4 11064.9 10178.1 10303.4 10323.7 10360.3 10385.6 10449.2 10709.0 10873.1 11054.8 11109.7 8010.0 8034.8 8038.4 8126.8 8322.0 10067.5 10114.7 10276.5 10284.7 10285.4 23:11:03 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | [#3] mootools.html Cycles:180 Average:6126.89 Median:5522.63 stddev:3213.04 (58.2%) stddev-sans-first:3203.00 23:11:03 INFO - PROCESS | 5089 | Values: 1472.8 1584.9 1606.4 1838.6 1981.8 8225.8 8431.9 8439.6 8447.5 8451.7 8460.5 8625.6 8628.1 8637.4 8639.9 2181.5 2461.9 2508.6 2522.3 2541.1 2486.0 2503.9 2513.7 2516.1 2518.4 2495.8 2512.0 2513.4 2514.9 2515.6 2431.7 2508.0 2508.3 2508.5 2513.1 2464.7 2491.4 2503.1 2507.6 2508.4 8606.5 8640.0 8666.1 8671.3 8680.6 5368.5 5487.6 5534.1 5543.9 5544.0 3202.6 3236.3 3256.5 3257.3 3282.7 979.5 988.1 991.7 997.3 1029.4 12452.0 12495.3 12499.4 12509.7 12511.0 4823.6 4837.0 4902.6 4910.5 4926.5 10400.7 10421.5 10422.9 10430.3 10431.6 4897.7 5481.0 5521.1 5524.2 5527.3 4824.6 4851.9 4903.0 4909.2 4914.0 4005.7 4051.3 4088.8 4104.1 4108.7 1313.4 1335.9 1338.4 1342.1 1349.2 1403.8 1477.3 1490.6 1500.6 1519.8 8169.8 8271.0 8338.0 8346.8 8351.3 1175.7 1189.0 1219.8 1251.3 1278.4 6405.4 6431.6 6476.6 6510.4 6522.7 10279.7 10744.7 10765.9 10783.3 10905.2 10570.9 10651.8 10892.3 10920.7 10972.5 8402.2 8474.4 8554.5 8554.9 8567.4 7865.6 8046.3 8064.4 8107.8 8115.5 9094.0 9213.6 9271.3 9523.7 9543.1 9446.3 9557.9 9559.5 9782.0 9783.5 6989.3 7010.8 7939.4 8070.6 8077.7 8220.0 8237.7 8272.3 8276.4 8284.8 7253.3 7408.0 7501.7 7526.8 7683.7 7402.7 7417.6 7426.0 7550.7 7578.9 7731.5 7812.2 7817.8 7855.3 7865.8 6925.9 6994.1 7036.0 7059.3 7081.4 7329.3 7399.9 7462.0 7468.7 7474.9 23:11:03 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | [#4] prototype.html Cycles:180 Average:5385.37 Median:6126.36 stddev:1585.01 (25.9%) stddev-sans-first:1544.04 23:11:03 INFO - PROCESS | 5089 | Values: 366.1 366.9 367.7 372.3 380.6 5984.1 6009.5 6016.6 6028.5 6042.8 5958.7 5966.0 5971.0 5975.7 5981.6 4512.2 4612.3 4727.9 4742.3 4751.4 4731.2 4751.9 4753.5 4755.3 4755.6 4716.3 4716.5 4729.7 4731.4 4733.8 4446.3 4572.9 4640.8 4655.6 4667.4 4155.9 4205.6 4216.0 4217.9 4219.7 5738.3 5740.4 5741.8 5755.3 5766.0 5516.6 5518.8 5519.7 5523.9 5526.9 6315.3 6335.5 6346.7 6348.3 6366.6 4391.0 4524.5 4533.8 4537.9 4674.6 6580.3 6644.2 6659.0 6660.0 6661.8 4663.8 4664.7 4664.9 4666.7 4667.2 4735.4 4739.3 4742.2 4743.4 4744.0 5403.4 5414.6 5416.6 5418.6 5419.6 6313.1 6438.6 6447.1 6449.8 6458.3 1647.2 1659.5 1667.9 1668.6 1669.5 1017.9 1089.4 1096.6 1110.6 1135.4 6154.0 6157.2 6160.0 6168.8 6174.0 6535.8 6539.7 6540.7 6555.4 6557.9 6153.2 6157.5 6158.0 6158.6 6170.1 3481.5 3513.4 3518.7 3520.9 3524.1 6590.7 6698.8 6756.1 6756.3 6759.0 6697.5 6701.8 6703.3 6710.3 6712.1 6723.8 6731.6 6737.2 6739.9 6742.1 6504.1 6506.3 6507.1 6511.8 6521.9 6367.7 6421.2 6441.8 6485.8 6598.2 6842.2 6869.7 6886.6 6888.7 6899.3 4793.6 4847.6 4851.8 4858.3 4859.3 6610.2 6614.5 6618.0 6622.5 6623.3 6109.5 6308.1 6414.1 6416.3 6419.2 6312.1 6451.8 6477.4 6482.6 6484.5 6344.6 6354.9 6357.8 6361.5 6368.4 6486.9 6500.9 6508.8 6516.9 6518.6 6143.2 6308.4 6353.6 6355.6 6390.3 23:11:03 INFO - PROCESS | 5089 | 23:11:03 INFO - PROCESS | 5089 | [#5] yui.html Cycles:180 Average:14137.56 Median:48452.52 stddev:16403.28 (33.9%) stddev-sans-first:16418.66 23:11:03 INFO - PROCESS | 5089 | Values: 787.8 798.2 812.5 865.5 882.2 12916.3 13079.6 13085.2 13114.3 13136.9 12289.1 12308.9 12316.7 12350.1 12361.3 758.1 876.1 886.1 891.9 895.6 890.3 901.3 901.4 901.5 902.5 945.1 950.6 950.9 951.3 952.2 788.2 938.2 959.8 961.0 961.2 714.3 714.3 714.9 715.2 715.7 12823.1 12929.2 12968.2 13002.7 13003.2 12917.2 13577.0 13903.9 14245.8 14286.5 11395.3 11441.6 11597.9 11736.8 11878.5 3788.9 3815.7 3870.5 3937.9 3965.3 51777.0 52936.0 54612.0 54755.5 54999.7 10794.3 11068.2 11263.3 11348.4 11378.4 18650.2 18700.5 18701.7 18712.0 18788.4 8346.4 8371.7 8475.8 8526.1 8551.9 4434.9 4518.4 4525.5 4636.4 4693.1 3389.2 3430.1 3435.9 3452.7 3453.4 590.5 622.0 624.3 631.6 678.4 608.4 646.2 683.8 684.7 698.8 7737.5 7873.6 7965.1 8004.4 8073.7 526.4 613.3 634.8 654.7 674.3 3765.7 3786.8 3789.0 3797.3 3851.3 58060.4 58303.4 58794.4 59185.7 59608.4 49167.0 49682.8 50126.7 50415.2 51237.0 48392.8 48512.3 49060.8 49320.5 49453.0 8214.3 8357.5 8379.1 8383.9 8467.6 35235.0 35692.1 36028.0 37164.3 37466.4 39100.0 39587.8 44737.0 44763.3 44921.6 11309.6 11813.5 12085.5 12340.8 12845.6 11834.9 11855.5 11907.3 11983.6 12062.5 11177.9 11193.2 11411.7 11629.7 11901.8 10814.7 10958.2 11177.2 11524.3 11764.8 11008.6 11202.2 11307.1 11419.3 11521.4 9365.1 9366.1 9642.0 9731.0 9764.4 9442.0 9496.9 9608.6 9721.0 9882.2 23:11:03 INFO - PROCESS | 5089 | -------- Summary: end -------- 23:11:03 INFO - PROCESS | 5089 | 23:11:04 INFO - TEST-INFO | 5089: exit 0 23:11:04 INFO - TEST-OK | dromaeo_css | took 1112177ms 23:11:04 INFO - TEST-START | kraken 23:11:04 INFO - operating with platform_type : linux_ 23:11:04 INFO - Initialising browser for kraken test... 23:11:04 INFO - TEST-INFO | started process 5277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3q04Lq/profile http://localhost:46443/getInfo.html) 23:11:08 INFO - PROCESS | 5277 | __metrics Screen width/height:1600/1200 23:11:08 INFO - PROCESS | 5277 | colorDepth:24 23:11:08 INFO - PROCESS | 5277 | Browser inner width/height: 1024/697 23:11:08 INFO - PROCESS | 5277 | __metrics 23:11:09 INFO - PROCESS | 5277 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:11:10 INFO - TEST-INFO | 5277: exit 0 23:11:10 INFO - Browser initialized. 23:11:10 INFO - Running cycle 1/1 for kraken test... 23:11:10 INFO - TEST-INFO | started process 5365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3q04Lq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:21 INFO - PROCESS | 5365 | RSS: Main: 141877248 23:11:21 INFO - PROCESS | 5365 | 23:11:24 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46443/tests/kraken/driver.html?testName=audio-beat-detection) 23:11:24 INFO - PROCESS | 5365 | RSS: Main: 177455104 23:11:24 INFO - PROCESS | 5365 | 23:11:27 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46443/tests/kraken/driver.html?testName=audio-dft) 23:11:28 INFO - PROCESS | 5365 | RSS: Main: 176201728 23:11:28 INFO - PROCESS | 5365 | 23:11:30 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46443/tests/kraken/driver.html?testName=audio-fft) 23:11:31 INFO - PROCESS | 5365 | RSS: Main: 174649344 23:11:31 INFO - PROCESS | 5365 | 23:11:33 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46443/tests/kraken/driver.html?testName=audio-oscillator) 23:11:34 INFO - PROCESS | 5365 | RSS: Main: 174682112 23:11:34 INFO - PROCESS | 5365 | 23:11:36 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:11:36 INFO - PROCESS | 5365 | RSS: Main: 171991040 23:11:36 INFO - PROCESS | 5365 | 23:11:39 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46443/tests/kraken/driver.html?testName=imaging-darkroom) 23:11:40 INFO - PROCESS | 5365 | RSS: Main: 172044288 23:11:40 INFO - PROCESS | 5365 | 23:11:43 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46443/tests/kraken/driver.html?testName=imaging-desaturate) 23:11:44 INFO - PROCESS | 5365 | RSS: Main: 172429312 23:11:44 INFO - PROCESS | 5365 | 23:11:47 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46443/tests/kraken/driver.html?testName=json-parse-financial) 23:11:47 INFO - PROCESS | 5365 | RSS: Main: 171991040 23:11:47 INFO - PROCESS | 5365 | 23:11:49 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:11:49 INFO - PROCESS | 5365 | RSS: Main: 178008064 23:11:49 INFO - PROCESS | 5365 | 23:11:51 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46443/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:11:52 INFO - PROCESS | 5365 | RSS: Main: 177262592 23:11:52 INFO - PROCESS | 5365 | 23:11:54 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:11:54 INFO - PROCESS | 5365 | RSS: Main: 182652928 23:11:54 INFO - PROCESS | 5365 | 23:11:57 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:11:57 INFO - PROCESS | 5365 | RSS: Main: 189440000 23:11:57 INFO - PROCESS | 5365 | 23:12:00 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:12:00 INFO - PROCESS | 5365 | RSS: Main: 189075456 23:12:00 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | Cycle 1(1): loaded http://localhost:46443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46443/tests/kraken/driver.html?testName=ai-astar) 23:12:02 INFO - PROCESS | 5365 | RSS: Main: 251174912 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | __start_tp_report 23:12:02 INFO - PROCESS | 5365 | _x_x_mozilla_page_load 23:12:02 INFO - PROCESS | 5365 | _x_x_mozilla_page_load_details 23:12:02 INFO - PROCESS | 5365 | |i|pagename|runs| 23:12:02 INFO - PROCESS | 5365 | |0;ai-astar;109;110;106;107;110;111;99;109;109;109 23:12:02 INFO - PROCESS | 5365 | |1;audio-beat-detection;153;125;149;163;128;152;152;134;169;125 23:12:02 INFO - PROCESS | 5365 | |2;audio-dft;160;160;162;161;161;161;160;163;162;161 23:12:02 INFO - PROCESS | 5365 | |3;audio-fft;76;75;75;162;73;76;76;76;160;76 23:12:02 INFO - PROCESS | 5365 | |4;audio-oscillator;92;92;147;92;93;94;140;92;92;138 23:12:02 INFO - PROCESS | 5365 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;116;117;117 23:12:02 INFO - PROCESS | 5365 | |6;imaging-darkroom;146;145;146;173;145;146;145;146;145;146 23:12:02 INFO - PROCESS | 5365 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 23:12:02 INFO - PROCESS | 5365 | |8;json-parse-financial;54;55;61;54;55;55;55;63;52;53 23:12:02 INFO - PROCESS | 5365 | |9;json-stringify-tinderbox;65;65;64;65;65;65;65;65;65;65 23:12:02 INFO - PROCESS | 5365 | |10;stanford-crypto-aes;77;76;80;78;79;79;79;78;79;78 23:12:02 INFO - PROCESS | 5365 | |11;stanford-crypto-ccm;111;112;110;119;113;112;110;122;110;118 23:12:02 INFO - PROCESS | 5365 | |12;stanford-crypto-pbkdf2;146;135;145;146;148;135;145;144;143;143 23:12:02 INFO - PROCESS | 5365 | |13;stanford-crypto-sha256-iterative;68;70;70;70;68;67;69;69;69;67 23:12:02 INFO - PROCESS | 5365 | __end_tp_report 23:12:02 INFO - PROCESS | 5365 | __start_cc_report 23:12:02 INFO - PROCESS | 5365 | _x_x_mozilla_cycle_collect,1053 23:12:02 INFO - PROCESS | 5365 | __end_cc_report 23:12:02 INFO - PROCESS | 5365 | __startTimestamp1461478322690__endTimestamp 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | ------- Summary: start ------- 23:12:02 INFO - PROCESS | 5365 | Number of tests: 14 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.45 (3.1%) stddev-sans-first:3.63 23:12:02 INFO - PROCESS | 5365 | Values: 109.0 110.0 106.0 107.0 110.0 111.0 99.0 109.0 109.0 109.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:152.00 stddev:15.94 (10.5%) stddev-sans-first:16.65 23:12:02 INFO - PROCESS | 5365 | Values: 153.0 125.0 149.0 163.0 128.0 152.0 152.0 134.0 169.0 125.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 23:12:02 INFO - PROCESS | 5365 | Values: 160.0 160.0 162.0 161.0 161.0 161.0 160.0 163.0 162.0 161.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:36.12 (47.5%) stddev-sans-first:37.81 23:12:02 INFO - PROCESS | 5365 | Values: 76.0 75.0 75.0 162.0 73.0 76.0 76.0 76.0 160.0 76.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:92.00 stddev:23.90 (26.0%) stddev-sans-first:24.71 23:12:02 INFO - PROCESS | 5365 | Values: 92.0 92.0 147.0 92.0 93.0 94.0 140.0 92.0 92.0 138.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:12:02 INFO - PROCESS | 5365 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:146.00 stddev:8.69 (6.0%) stddev-sans-first:9.18 23:12:02 INFO - PROCESS | 5365 | Values: 146.0 145.0 146.0 173.0 145.0 146.0 145.0 146.0 145.0 146.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 23:12:02 INFO - PROCESS | 5365 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.50 (6.4%) stddev-sans-first:3.66 23:12:02 INFO - PROCESS | 5365 | Values: 54.0 55.0 61.0 54.0 55.0 55.0 55.0 63.0 52.0 53.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 23:12:02 INFO - PROCESS | 5365 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.00 stddev:1.16 (1.5%) stddev-sans-first:1.13 23:12:02 INFO - PROCESS | 5365 | Values: 77.0 76.0 80.0 78.0 79.0 79.0 79.0 78.0 79.0 78.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:112.50 stddev:4.35 (3.9%) stddev-sans-first:4.50 23:12:02 INFO - PROCESS | 5365 | Values: 111.0 112.0 110.0 119.0 113.0 112.0 110.0 122.0 110.0 118.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:145.00 stddev:4.47 (3.1%) stddev-sans-first:4.61 23:12:02 INFO - PROCESS | 5365 | Values: 146.0 135.0 145.0 146.0 148.0 135.0 145.0 144.0 143.0 143.0 23:12:02 INFO - PROCESS | 5365 | 23:12:02 INFO - PROCESS | 5365 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 23:12:02 INFO - PROCESS | 5365 | Values: 68.0 70.0 70.0 70.0 68.0 67.0 69.0 69.0 69.0 67.0 23:12:02 INFO - PROCESS | 5365 | -------- Summary: end -------- 23:12:02 INFO - PROCESS | 5365 | 23:12:03 INFO - TEST-INFO | 5365: exit 0 23:12:03 INFO - TEST-OK | kraken | took 59575ms 23:12:03 INFO - SUITE-END | took 1171s 23:12:03 INFO - Completed test suite (00:19:31) 23:12:03 INFO - javascript benchmark 23:12:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3265.591801024872, 3302.306515631717, 3316.718078963288, 3320.2031512437025, 3347.8995630131103, 5294.57643388529, 5317.175837745151, 5323.680579165253, 5344.971362658107, 5374.328208973879, 5316.574674026078, 5347.144456886899, 5349.545288650469, 5367.731613419333, 5375.784968601261, 4824.903501929959, 4923.212286034235, 4937.530934561229, 4991.176455884774, 5015.673981191229, 4854.12625727369, 4878.146324393235, 4937.728424936627, 4945.950540494585, 4948.703077815325, 4935.679180853233, 5011.749412529377, 5031.949680503185, 5033.320501732274, 5063.088644044071, 4917.041176970492, 4947.876303092416, 4953.678010929278, 4970.751462426882, 4983.875403114915, 4797.688150270221, 4944.53026962438, 4955.801767929279, 4991.07665081961, 5001.674891132101, 5250.737463126867, 5310.654807437504, 5317.9468205317835, 5330.440303768126, 5347.144456886879, 5719.428057194289, 5722.0, 5729.598928075036, 5730.312362516524, 5736.0, 5679.829605111812, 5711.029125048752, 5730.226419433365, 5757.539396848242, 5768.42315768424, 5458.563314934835, 5468.535174510172, 5472.589555783293, 5473.397926228112, 5498.3127109111365, 5951.5238780897425, 5955.076963070731, 5955.225820643289, 5959.970200148971, 5961.5230781537375, 5526.088195447786, 5689.231953686282, 5690.459406356389, 5708.457696518824, 5791.913121303184, 5839.824805255849, 5843.211166492554, 5843.795467158714, 5844.386339434298, 5845.970770146122, 5765.913511297334, 5783.248177736868, 5787.826365209051, 5789.131630255495, 5790.0, 5650.858728531737, 5712.171735098387, 5774.04728219839, 5791.362950075489, 5799.420057994167, 4390.780460976938, 4392.3191905254735, 4393.275109606943, 4394.978025109854, 4410.536893626123, 3966.167104907944, 3971.900702482403, 3973.7615743055508, 3983.64147226751, 3993.3011722948368, 5329.094054010828, 5476.479734425223, 5545.611807173459, 5554.583406244547, 5567.359753628303, 5763.423657634287, 5798.0, 5807.361190269067, 5814.476697097281, 5826.359100498942, 5298.125809241509, 5438.374586922555, 5481.835544933659, 5492.231087647732, 5502.532284755841, 4911.16510193268, 4968.453470118284, 4971.403431588233, 4982.77577509013, 5010.198368261061, 5901.822945311647, 5957.940420595825, 5960.403959604092, 5963.0459126539545, 5970.940290597038, 5636.887262254814, 5743.483086522233, 5800.912986305125, 5802.071668533099, 5823.912641310299, 5933.080372542263, 5975.880482390415, 5984.311804142405, 5988.161657368059, 6016.4885984690045, 5731.197632331394, 5758.568107391879, 5768.826935191951, 5770.624909381045, 5784.479396854135, 5669.773209071756, 5797.768089276382, 5802.970985145047, 5832.066869301061, 5889.823305300848, 5600.915986260291, 5602.3837377887585, 5603.719814009201, 5604.495595396434, 5611.5230205433, 5573.916391254215, 5592.105263157875, 5600.243967064557, 5603.747831347518, 5613.24221230145, 5337.893242135213, 5510.972445137749, 5597.272354593877, 5654.6889921054735, 5682.687452190169, 5545.972270138785, 5630.493255607015, 5682.801101961411, 5706.172604972338, 5731.140328950691, 5587.441255874543, 5597.44025597437, 5606.103023516218, 5615.2700148980375, 5618.195859594961], "unit": "score", "name": "dojo.html", "value": 5337.764217352812}, {"lowerIsBetter": false, "replicates": [576.3659974028567, 584.6550535184241, 633.8922383194856, 639.5267502048484, 642.5855323316464, 32113.0, 40510.1897962041, 41026.58973410265, 41052.58947410525, 41107.383389249146, 44262.336064958974, 44804.55195448045, 44851.0, 45044.774776126156, 45138.32292515607, 8038.839223215561, 8181.79545511361, 8906.0, 9120.543972801366, 10487.056164945154, 10564.683059508188, 10668.519916603733, 10714.732131696692, 10736.24846260762, 10737.624183153592, 10671.19966002549, 10756.085732712729, 10768.192385571074, 10769.78460430791, 10780.676579702582, 10659.946700266488, 10701.143908487302, 10717.571297148104, 10744.30162039465, 10752.139828813677, 10602.946985265024, 10693.78612427747, 10711.785764284748, 10713.517891694892, 11028.117750579935, 44601.77699111516, 45056.774716126536, 45063.54936450626, 45129.54870451286, 45180.09639807185, 3530.258645684409, 3620.6741393274733, 3649.835757390924, 3672.338978983782, 3771.547414310273, 31473.842630786927, 33202.50196247058, 33315.6668433315, 33574.83212583946, 34043.31913361719, 3829.3872980323295, 3829.5213098362706, 3985.262726395597, 3987.641112299878, 3988.760674359548, 302711.0, 303128.0, 304089.0, 305701.0, 306088.0, 45292.773536132765, 45983.0, 46039.0, 67611.66194169097, 68113.0, 44037.559624403984, 44110.55889441064, 44235.77882110633, 44350.778246108566, 44504.3324350135, 14384.424623014962, 14392.280385980659, 14404.0, 14439.0, 14922.925385373004, 13115.803262951064, 13265.403056862464, 13298.534551290659, 13333.799993000113, 13345.0, 15857.524274271791, 15937.601559961095, 15937.920310398375, 15945.601359966093, 16040.358385664442, 5691.601587888808, 5709.714514274269, 5736.110902810071, 5747.770089196469, 5962.761489540457, 961.4663861556903, 1022.9232807539315, 1034.3018462537757, 1072.254782925859, 1099.1701265544464, 29897.701022989928, 30084.398312033638, 30433.391332173676, 30803.383932321227, 31024.22439438987, 1149.7010777197822, 1174.512577280436, 1226.5707002549216, 1242.937853107341, 1247.7379750252367, 15556.688866222612, 15743.974808045952, 15823.920880395524, 15840.0, 15968.201589920458, 336113.0, 341435.0, 342716.0, 342894.0, 343562.0, 58446.41553584495, 59594.0, 59654.701726491956, 59672.40327596669, 59715.61137554449, 1268.3341245846004, 1375.8968077394236, 1448.4133925760084, 1473.62422582243, 1517.1352329172487, 27881.581776272968, 28671.71328286774, 29838.0, 30632.540511892785, 30670.233244169074, 48385.27422088601, 48803.75598121987, 48985.265221021, 49041.0, 49061.75469122631, 204626.0, 205589.0, 205594.0, 206393.0, 206950.0, 31027.0, 34763.826180868935, 35149.47275790916, 35240.64759352374, 35794.10514737153, 56615.43384566101, 56986.0, 57400.0, 58011.41988580229, 58158.70920645539, 39422.211555769296, 39642.60357396389, 40498.39252411275, 40634.0, 40639.0, 40560.39159412552, 42581.78709106435, 42940.35589466098, 43636.78181609072, 44243.0, 43478.39120659506, 43531.34702979394, 43705.56294437015, 43958.340624891294, 44211.55788442203, 38249.426258605585, 39674.801625991684, 39747.40378894377, 39904.40143397793, 40397.0, 29555.261118472212, 29573.112806615834, 29977.850110749307, 30049.0, 30230.54654180233], "unit": "score", "name": "ext.html", "value": 19584.88019082039}, {"lowerIsBetter": false, "replicates": [378.07937671769224, 379.55023297392586, 383.7850803550011, 385.62594283544985, 388.4639197906888, 17754.378596749117, 18626.0, 19026.287634112927, 19287.421377358667, 19362.90318548407, 12465.065120116005, 12840.165389249692, 12844.550440734576, 12857.871421285785, 12861.614151575468, 4081.3061779497557, 5170.612204084689, 5279.5512381447625, 5828.504577110951, 5836.182934389189, 4157.355609880473, 5506.834794956158, 5710.257666503348, 5715.171300161474, 5720.084786434171, 5519.199716041172, 5683.715814209273, 5694.0, 5698.059820129673, 5698.886022279552, 5823.3012038555435, 5832.300123985149, 5859.824205273849, 5868.3838196989345, 5868.706564671771, 5484.506394424521, 5646.858828529279, 5648.209250704905, 5649.378568357477, 5651.604387692863, 21879.562408751735, 22021.559568808694, 22221.555568888693, 22245.332640020824, 22249.332520024425, 2096.6645336746046, 2182.2689399051337, 2313.4679023824615, 2523.7602427769334, 2783.2902609834364, 10223.437710925897, 10342.896571034269, 10559.841602375971, 10677.83983240252, 10876.0, 1916.1856211110223, 1934.0, 1969.3008981811395, 1984.5237143085699, 1995.0, 68458.65770671115, 70152.0, 70542.29457705408, 71004.0, 72068.27931720667, 10330.380177189392, 10576.41829699374, 10728.620484547499, 10783.29908555957, 10856.945715271373, 15217.31522081509, 15469.767953480707, 15549.455769048029, 15561.221938903009, 15574.065556066445, 7716.382689384835, 7877.7636670899965, 7940.0868900076075, 8001.399895007898, 8055.63749631268, 7707.614619269014, 7746.806329841799, 7764.184760600168, 7770.417218708506, 7812.218778122142, 4605.0, 4688.976555117202, 4750.097481478508, 4762.738049407316, 4797.136515427187, 1813.5375479252707, 1896.9905150474435, 1941.9417417477498, 1980.4454752669276, 1984.8015198480325, 922.3727865051695, 970.6505657963128, 983.4154506822591, 1002.3935519010894, 1016.5730393234859, 16014.919925400298, 16498.917505412635, 16597.419090332023, 16868.29969455579, 17339.306427743002, 961.6682244625594, 975.7755716185175, 977.2084611464736, 991.7520619845038, 1018.5671089786811, 9763.804723905481, 9933.0, 9958.452285124387, 9993.374943338336, 10144.847827282596, 465818.0, 468648.0, 475133.0, 476196.0, 479737.0, 81254.59372703217, 81473.18526814775, 81525.59237203776, 81716.18283817204, 83107.0, 1050.1808589300206, 1073.4471747050275, 1074.5164675895878, 1075.064693716456, 1091.5961094394966, 16054.839451605334, 16284.267207975432, 16303.755443668117, 16359.509214723577, 16534.09062501574, 22830.200942966916, 35749.1062723434, 36430.0, 36625.26749465049, 36697.44953825748, 49891.0, 52242.738786305825, 52553.7372313136, 52558.0, 52560.0, 7810.531368117931, 7909.209079092045, 8025.23760242776, 8036.557989310644, 8064.032316122103, 9068.818623627358, 11764.235324703866, 11800.114991375509, 11935.52257909674, 12288.692782680504, 10181.69505703802, 10246.129079028366, 10643.201759867887, 10796.406197659204, 11064.944675276573, 10178.13485853681, 10303.3817970922, 10323.690289291333, 10360.274780765274, 10385.584576616851, 10449.16406687448, 10709.0, 10873.07578855806, 11054.834177487504, 11109.722256943642, 8009.959950200212, 8034.83930321402, 8038.437309388287, 8126.75619731409, 8322.0, 10067.546960386946, 10114.747131321776, 10276.537555810157, 10284.742881428025, 10285.382877027403], "unit": "score", "name": "jquery.html", "value": 8664.179239803112}, {"lowerIsBetter": false, "replicates": [1472.7569950958093, 1584.920753962302, 1606.3895719626544, 1838.5863180784324, 1981.8315443187328, 8225.794355141124, 8431.873521897176, 8439.62021709023, 8447.493150410979, 8451.746447606567, 8460.450070745412, 8625.568721563928, 8628.137186281385, 8637.438566493189, 8639.913600863989, 2181.4982554012586, 2461.8645974471397, 2508.611165269386, 2522.3063657494154, 2541.0852093246417, 2486.0304481252324, 2503.8998440062373, 2513.673222481084, 2516.094206085808, 2518.3955850595908, 2495.800335973118, 2511.962320565193, 2513.3716570857287, 2514.88683009265, 2515.584928486807, 2431.683881095455, 2508.046942161985, 2508.297676650541, 2508.5108403861254, 2513.082724805451, 2464.6795916530737, 2491.402063504764, 2503.086373473687, 2507.6489291499206, 2508.3854455658297, 8606.526641034741, 8639.956800216021, 8666.090060543615, 8671.349648776304, 8680.565971701453, 5368.463153684639, 5487.64330318528, 5534.142207957773, 5543.916841247385, 5544.029794785896, 3202.647708752035, 3236.255661197914, 3256.462683657194, 3257.2996805686653, 3282.688144626257, 979.5200351827554, 988.0860204310984, 991.7371896447447, 997.3467378866853, 1029.3772267778036, 12452.0, 12495.312757798318, 12499.437525311383, 12509.687257818627, 12511.0, 4823.614110871122, 4836.975815120973, 4902.558769710672, 4910.48439913811, 4926.531979461945, 10400.739981500372, 10421.53103110362, 10422.947885260524, 10430.322029068086, 10431.634892778717, 4897.730624815598, 5481.013417584793, 5521.061419558685, 5524.1989911462615, 5527.309086364205, 4824.565789079, 4851.902961940741, 4903.0, 4909.214525675875, 4913.950860491421, 4005.719599627998, 4051.311277082903, 4088.7546747195265, 4104.076582768913, 4108.6918481114035, 1313.356455336878, 1335.8978842455012, 1338.4110991164052, 1342.1276170489066, 1349.156777014366, 1403.7964495148146, 1477.30566633682, 1490.6496973211288, 1500.5648361975122, 1519.8100237470317, 8169.79575510617, 8271.0, 8337.95775528059, 8346.789715491219, 8351.331893448509, 1175.6590588729343, 1189.0, 1219.7987332090106, 1251.2742609286593, 1278.3991523983898, 6405.391487808651, 6431.614103153825, 6476.579022363531, 6510.414062734282, 6522.706478208492, 10279.743006424898, 10744.677659670222, 10765.946170269099, 10783.29908555957, 10905.182111341523, 10570.947145264225, 10651.84022239667, 10892.292001019909, 10920.726981825359, 10972.506237219344, 8402.243798058204, 8474.449160804528, 8554.486730796172, 8554.871676924851, 8567.357448191411, 7865.567393793396, 8046.316063134699, 8064.435489515678, 8107.756767296991, 8115.51306921563, 9093.954530227307, 9213.58538865766, 9271.30465215098, 9523.666671666459, 9543.093406126407, 9446.29152813528, 9557.904420955701, 9559.522023898917, 9782.021797820445, 9783.461909594756, 6989.30106989297, 7010.789676309719, 7939.404544659058, 8070.596470176585, 8077.676892924217, 8219.95890020546, 8237.670493180205, 8272.33821294307, 8276.420650554644, 8284.792880178044, 7253.310935461122, 7407.962960185165, 7501.662425190989, 7526.849463010819, 7683.692652293846, 7402.703891844266, 7417.592032438268, 7426.0, 7550.735724249625, 7578.924210757822, 7731.536107833323, 7812.218778122142, 7817.765467035998, 7855.293023627901, 7865.764027079197, 6925.861482770417, 6994.125734283215, 7036.0, 7059.329363710439, 7081.433485321265, 7329.303716146957, 7399.889001665087, 7461.962690186514, 7468.738594149178, 7474.887876681745], "unit": "score", "name": "mootools.html", "value": 5015.209851864765}, {"lowerIsBetter": false, "replicates": [366.06470467954375, 366.93395188866026, 367.73523063394344, 372.2647770652961, 380.56235329371236, 5984.132300816379, 6009.4591486766185, 6016.5788394812325, 6028.547858910577, 6042.788502402417, 5958.731857066432, 5966.045432730764, 5971.0, 5975.701214939258, 5981.611195272304, 4512.165249428866, 4612.331211974261, 4727.905441891177, 4742.336072949781, 4751.3585665935, 4731.172044892147, 4751.857444276678, 4753.524647535236, 4755.334253204537, 4755.571998520132, 4716.339712440261, 4716.481187069419, 4729.739864307462, 4731.408573928259, 4733.786979585927, 4446.3108218226225, 4572.885677858064, 4640.79116439761, 4655.604273636745, 4667.416572928384, 4155.8753237402925, 4205.621494065518, 4216.0, 4217.915641687149, 4219.683523735732, 5738.254026976508, 5740.425957404268, 5741.770329186869, 5755.280589926259, 5766.04860198071, 5516.613837031409, 5518.779248830042, 5519.668819870821, 5523.861903452445, 5526.944730552683, 6315.336889626569, 6335.493160547145, 6346.6509341986175, 6348.301686814447, 6366.649834259114, 4390.978045109786, 4524.502304746476, 4533.795979180912, 4537.931931021038, 4674.579287864109, 6580.341965803429, 6644.169478815148, 6659.03444000622, 6660.0, 6661.766838160641, 4663.813447462131, 4664.65015123867, 4664.906701865943, 4666.673332866667, 4667.206574882278, 4735.384400028043, 4739.2891066339635, 4742.170120228946, 4743.407074115736, 4743.976280118577, 5403.405625381205, 5414.593905457106, 5416.566674666017, 5418.620696551204, 5419.566434685295, 6313.116163737081, 6438.645874476855, 6447.097406363113, 6449.774257900951, 6458.2895881453005, 1647.184643601401, 1659.5104444188994, 1667.924943377551, 1668.6329007618303, 1669.4741156535651, 1017.9389236645825, 1089.4498278369372, 1096.6456426313496, 1110.622388387952, 1135.3585224348217, 6154.0, 6157.168782214433, 6159.96920015406, 6168.753249870045, 6174.043023331391, 6535.771248006392, 6539.738410463528, 6540.738370465128, 6555.3772391622715, 6557.901631475532, 6153.2000839890525, 6157.507399408037, 6158.0, 6158.568900176944, 6170.074488826622, 3481.4951831984727, 3513.350030244413, 3518.7185025197923, 3520.9295814083575, 3524.101354154674, 6590.670466476657, 6698.765543205965, 6756.121704178426, 6756.2568117507035, 6758.966205169041, 6697.497687673444, 6701.765438209639, 6703.3296670332575, 6710.328967103348, 6712.060311556386, 6723.798286051328, 6731.562448440835, 6737.225219099768, 6739.865202695919, 6742.123523941954, 6504.089427480251, 6506.284308726131, 6507.056476810931, 6511.772087976898, 6521.934780652133, 6367.713452894538, 6421.197350331208, 6441.774537891151, 6485.805425837232, 6598.208215014229, 6842.24735279109, 6869.725210991504, 6886.586804791728, 6888.655567221719, 6899.275576064441, 4793.640476964311, 4847.587955023721, 4851.805927762991, 4858.319835223001, 4859.343988561499, 6610.206775187008, 6614.4708423325055, 6618.0, 6622.503312251697, 6623.3376662333385, 6109.480694141048, 6308.053791931247, 6414.069959855701, 6416.294207637063, 6419.197600299963, 6312.116303717391, 6451.838704032437, 6477.4170324671, 6482.643454610042, 6484.481241500763, 6344.619322840645, 6354.93645063562, 6357.777477788441, 6361.491080713625, 6368.395002474757, 6486.9351306488215, 6500.934990650033, 6508.8047358579315, 6516.902246466212, 6518.57629254097, 6143.232095988002, 6308.400701933309, 6353.618782873043, 6355.618662880242, 6390.329015453311], "unit": "score", "name": "prototype.html", "value": 4877.575499921149}, {"lowerIsBetter": false, "replicates": [787.8030492376906, 798.2257210505808, 812.480012791813, 865.545588566003, 882.2236431939892, 12916.289604071771, 13079.60761177165, 13085.21488710678, 13114.278714670689, 13136.934315328434, 12289.139760216765, 12308.876911230886, 12316.692082697937, 12350.135490515668, 12361.258324500537, 758.0751483190527, 876.0801158783252, 886.1404437695458, 891.9331050171247, 895.5790778334173, 890.3366991591273, 901.324006994754, 901.432097778402, 901.486152892848, 902.5171533229724, 945.0927109974433, 950.6435086842434, 950.8906475755308, 951.3245595627078, 952.2049089010684, 788.1921030943272, 938.2212763406391, 959.7552624080885, 960.9951950240204, 961.2310151878469, 714.2678754276856, 714.3071220915704, 714.9106361704787, 715.2382712411265, 715.7316006497564, 12823.102382833205, 12929.224246545238, 12968.221906685534, 13002.674933126653, 13003.154794938393, 12917.224966501946, 13577.0, 13903.930480347635, 14245.78631320531, 14286.499972501017, 11395.316281023164, 11441.599544015919, 11597.884021159765, 11736.765264694659, 11878.524859005629, 3788.9431658525145, 3815.7468139760967, 3870.4774855394444, 3937.9212415751813, 3965.286248475273, 51777.0, 52936.0, 54612.0, 54755.452445475836, 54999.72500137514, 10794.298370605886, 11068.225224234226, 11263.324200547993, 11348.432578371214, 11378.374189419661, 18650.16074276661, 18700.532486687942, 18701.719474207897, 18712.0, 18788.436346909613, 8346.374021948379, 8371.706990255312, 8475.788105297417, 8526.147385261549, 8551.871721924175, 4434.866953991385, 4518.390017347681, 4525.456945166601, 4636.397268355092, 4693.108309421199, 3389.1527118220447, 3430.142464383904, 3435.862565497402, 3452.7065199457825, 3453.3611281912927, 590.4597293476506, 621.9813405597839, 624.2664868779257, 631.6462780842743, 678.4131726057024, 608.397686290578, 646.2116218213772, 683.8085336105898, 684.7466437418187, 698.8043347862607, 7737.535747855147, 7873.606319683993, 7965.123836377994, 8004.439689221698, 8073.748568971819, 526.3525863188299, 613.3375953969702, 634.7746549974785, 654.7446495866616, 674.275154209227, 3765.6987441004653, 3786.8106594670708, 3789.0, 3797.316483033025, 3851.30676478231, 58060.41939580635, 58303.41696583065, 58794.35425405867, 59185.70407148023, 59608.40391596028, 49167.0, 49682.75158624256, 50126.74936625294, 50415.243771343456, 51237.0, 48392.758036210296, 48512.27231591529, 49060.75469622629, 49320.506794932306, 49453.0, 8214.3428525719, 8357.498550087013, 8379.120192379713, 8383.874241886255, 8467.61895714682, 35235.0, 35692.10769730777, 36028.0, 37164.25671486609, 37466.43800342942, 39100.0, 39587.80206098951, 44737.0, 44763.32855007112, 44921.55078449305, 11309.604163854226, 11813.527458901548, 12085.516579336729, 12340.753184936071, 12845.614631561068, 11834.940825295818, 11855.466504007512, 11907.285562866256, 11983.64049078529, 12062.457189426672, 11177.944110279397, 11193.216474846682, 11411.657650270505, 11629.659000793155, 11901.821472677744, 10814.675559733221, 10958.178136639624, 11177.217594768288, 11524.308541487537, 11764.823527647264, 11008.614698485515, 11202.159838012345, 11307.095432365226, 11419.31484110956, 11521.423928803693, 9365.082533282595, 9366.110219529133, 9642.0, 9731.0, 9764.365316254421, 9442.0, 9496.905030949878, 9608.615655373707, 9721.027897210222, 9882.160016398399], "unit": "score", "name": "yui.html", "value": 6532.775639307375}], "name": "dromaeo_css", "value": 7246.124489699057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 107.0, 110.0, 111.0, 99.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 149.0, 163.0, 128.0, 152.0, 152.0, 134.0, 169.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 160.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 162.0, 73.0, 76.0, 76.0, 76.0, 160.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 147.0, 92.0, 93.0, 94.0, 140.0, 92.0, 92.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 173.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 61.0, 54.0, 55.0, 55.0, 55.0, 63.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 80.0, 78.0, 79.0, 79.0, 79.0, 78.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.3}, {"lowerIsBetter": true, "replicates": [111.0, 112.0, 110.0, 119.0, 113.0, 112.0, 110.0, 122.0, 110.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.7}, {"lowerIsBetter": true, "replicates": [146.0, 135.0, 145.0, 146.0, 148.0, 135.0, 145.0, 144.0, 143.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 70.0, 68.0, 67.0, 69.0, 69.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1498.1000000000001}]} 23:12:03 INFO - Return code: 0 23:12:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:12:03 INFO - # TBPL SUCCESS # 23:12:03 INFO - Running post-action listener: _resource_record_post_action 23:12:03 INFO - Running post-run listener: _resource_record_post_run 23:12:05 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 278528; Write bytes: 251138048; Read time: 48; Write time: 181540 23:12:05 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 1224704; Read time: 0; Write time: 64 23:12:05 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 278528; Write bytes: 249913344; Read time: 48; Write time: 181476 23:12:05 INFO - Running post-run listener: _upload_blobber_files 23:12:05 INFO - Blob upload gear active. 23:12:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:12:05 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 23:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:12:05 INFO - (blobuploader) - INFO - Open directory for files ... 23:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:06 INFO - (blobuploader) - INFO - Done attempting. 23:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:07 INFO - (blobuploader) - INFO - Done attempting. 23:12:07 INFO - (blobuploader) - INFO - Iteration through files over. 23:12:07 INFO - Return code: 0 23:12:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:12:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:12:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/260bb8ffab0dd9785ed8c9ad20221ef9d58a7acff1f09f9b4b55ea250bf60660cc6ace10f44770e6a1706e87f961d1d548601733641f8bdf1ef6dd3d6c413ad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9beb6cff3d68770de2f7711eabada6f9c42b66f8fa10282e10612f860abbc08b56db6e8411aa9b7b2417db75b6df358b3a89e02b7d8fd3fe4f4f5ca820f25622"} 23:12:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:12:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:12:07 INFO - Contents: 23:12:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/260bb8ffab0dd9785ed8c9ad20221ef9d58a7acff1f09f9b4b55ea250bf60660cc6ace10f44770e6a1706e87f961d1d548601733641f8bdf1ef6dd3d6c413ad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9beb6cff3d68770de2f7711eabada6f9c42b66f8fa10282e10612f860abbc08b56db6e8411aa9b7b2417db75b6df358b3a89e02b7d8fd3fe4f4f5ca820f25622"} 23:12:07 INFO - Running post-run listener: copy_logs_to_upload_dir 23:12:07 INFO - Copying logs to upload dir... 23:12:07 INFO - mkdir: /builds/slave/test/build/upload/logs 23:12:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.339845 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-23 23:12:07.465015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 23:12:07.468615) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/260bb8ffab0dd9785ed8c9ad20221ef9d58a7acff1f09f9b4b55ea250bf60660cc6ace10f44770e6a1706e87f961d1d548601733641f8bdf1ef6dd3d6c413ad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9beb6cff3d68770de2f7711eabada6f9c42b66f8fa10282e10612f860abbc08b56db6e8411aa9b7b2417db75b6df358b3a89e02b7d8fd3fe4f4f5ca820f25622"} build_url:https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/NbhB-bobSEiQiAq4uhPxJQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/260bb8ffab0dd9785ed8c9ad20221ef9d58a7acff1f09f9b4b55ea250bf60660cc6ace10f44770e6a1706e87f961d1d548601733641f8bdf1ef6dd3d6c413ad8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9beb6cff3d68770de2f7711eabada6f9c42b66f8fa10282e10612f860abbc08b56db6e8411aa9b7b2417db75b6df358b3a89e02b7d8fd3fe4f4f5ca820f25622"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 23:12:07.493607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:12:07.493938) ========= 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=c6927cf182745ad25b1d38b9000001fe-1461476127.183357-1436159538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:12:07.579952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 23:12:07.580277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 23:12:07.580559) ========= ========= Total master_lag: 0.17 =========