builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1460727064.02 results: success (0) buildid: 20160415052445 builduid: c291f87fc2d6423e9a7d7ce2259de22e revision: 0260dd297a25b97b11dfa208c3d556cb7b62542c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.019637) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.020101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.020382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.039555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.039943) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 06:31:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-04-15 06:31:04 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105653 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.161770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.162096) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016585 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.211298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.215694) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0260dd297a25b97b11dfa208c3d556cb7b62542c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0260dd297a25b97b11dfa208c3d556cb7b62542c --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=03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 06:31:04,547 truncating revision to first 12 chars 2016-04-15 06:31:04,547 Setting DEBUG logging. 2016-04-15 06:31:04,548 attempt 1/10 2016-04-15 06:31:04,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0260dd297a25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 06:31:04,783 unpacking tar archive at: fx-team-0260dd297a25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.744749) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.745065) ========= script_repo_revision: 0260dd297a25b97b11dfa208c3d556cb7b62542c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.745461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.745742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 06:31:04.754695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-15 06:31:04.754971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:31:05 INFO - MultiFileLogger online at 20160415 06:31:05 in /builds/slave/test 06:31:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:31:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:31:05 INFO - {'append_to_log': False, 06:31:05 INFO - 'base_work_dir': '/builds/slave/test', 06:31:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:31:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:31:05 INFO - 'branch': 'Fx-Team-Non-PGO', 06:31:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:31:05 INFO - 'config_files': ('talos/linux_config.py',), 06:31:05 INFO - 'default_actions': ('clobber', 06:31:05 INFO - 'read-buildbot-config', 06:31:05 INFO - 'download-and-extract', 06:31:05 INFO - 'populate-webroot', 06:31:05 INFO - 'create-virtualenv', 06:31:05 INFO - 'install', 06:31:05 INFO - 'run-tests'), 06:31:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:31:05 INFO - 'download_minidump_stackwalk': True, 06:31:05 INFO - 'download_symbols': 'ondemand', 06:31:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:31:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:31:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:31:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:31:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:31:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:31:05 INFO - 'installer_path': 'installer.exe', 06:31:05 INFO - 'log_level': 'info', 06:31:05 INFO - 'log_name': 'talos', 06:31:05 INFO - 'log_to_console': True, 06:31:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:31:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:31:05 INFO - 'opt_config_files': (), 06:31:05 INFO - 'pip_index': False, 06:31:05 INFO - 'sps_profile': False, 06:31:05 INFO - 'sps_profile_interval': 0, 06:31:05 INFO - 'suite': 'dromaeojs-e10s', 06:31:05 INFO - 'system_bits': '32', 06:31:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:31:05 INFO - 'title': 'talos-linux64-ix-047', 06:31:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:31:05 INFO - 'use_talos_json': True, 06:31:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:31:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:31:05 INFO - 'work_dir': 'build'} 06:31:05 INFO - ##### 06:31:05 INFO - ##### Running clobber step. 06:31:05 INFO - ##### 06:31:05 INFO - Running pre-action listener: _resource_record_pre_action 06:31:05 INFO - Running main action method: clobber 06:31:05 INFO - rmtree: /builds/slave/test/build 06:31:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:31:05 INFO - Running post-action listener: _resource_record_post_action 06:31:05 INFO - ##### 06:31:05 INFO - ##### Running read-buildbot-config step. 06:31:05 INFO - ##### 06:31:05 INFO - Running pre-action listener: _resource_record_pre_action 06:31:05 INFO - Running main action method: read_buildbot_config 06:31:05 INFO - Using buildbot properties: 06:31:05 INFO - { 06:31:05 INFO - "project": "", 06:31:05 INFO - "product": "firefox", 06:31:05 INFO - "script_repo_revision": "production", 06:31:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:31:05 INFO - "repository": "", 06:31:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:31:05 INFO - "buildid": "20160415052445", 06:31:05 INFO - "pgo_build": "False", 06:31:05 INFO - "basedir": "/builds/slave/test", 06:31:05 INFO - "buildnumber": 1157, 06:31:05 INFO - "slavename": "talos-linux64-ix-047", 06:31:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:31:05 INFO - "platform": "ubuntu64_hw", 06:31:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:31:05 INFO - "branch": "fx-team", 06:31:05 INFO - "repo_path": "integration/fx-team", 06:31:05 INFO - "revision": "0260dd297a25b97b11dfa208c3d556cb7b62542c", 06:31:05 INFO - "stage_platform": "linux64", 06:31:05 INFO - "builduid": "c291f87fc2d6423e9a7d7ce2259de22e", 06:31:05 INFO - "slavebuilddir": "test" 06:31:05 INFO - } 06:31:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:31:05 INFO - Running post-action listener: _resource_record_post_action 06:31:05 INFO - ##### 06:31:05 INFO - ##### Running download-and-extract step. 06:31:05 INFO - ##### 06:31:05 INFO - Running pre-action listener: _resource_record_pre_action 06:31:05 INFO - Running main action method: download_and_extract 06:31:05 INFO - mkdir: /builds/slave/test/build/tests 06:31: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')]} 06:31:05 INFO - https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:31:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:31:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:31:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:31:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:31:06 INFO - Downloaded 1361 bytes. 06:31:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:31:06 INFO - Using the following test package requirements: 06:31:06 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:31:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:31:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:31:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:06 INFO - u'jsshell-linux-x86_64.zip'], 06:31:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:31:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:31:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:31:06 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:31:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:31:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:31:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:31:06 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')]} 06:31:06 INFO - https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:31:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:31:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:31:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:31:07 INFO - Downloaded 22205647 bytes. 06:31:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:31:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:31:08 INFO - Return code: 0 06:31:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:08 INFO - https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:31:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:31:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:31:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:31:09 INFO - Downloaded 22205647 bytes. 06:31:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:31:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:31:11 INFO - Return code: 0 06:31:11 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')]} 06:31:11 INFO - https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:31:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:31:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:31:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:31:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:31:12 INFO - Downloaded 10841076 bytes. 06:31:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:31:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:31:12 INFO - Return code: 0 06:31: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')]} 06:31:12 INFO - https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:31:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:31:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:31:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:31:13 INFO - Downloaded 54451462 bytes. 06:31:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:31:13 INFO - mkdir: /builds/slave/test/properties 06:31:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:31:13 INFO - Writing to file /builds/slave/test/properties/build_url 06:31:13 INFO - Contents: 06:31:13 INFO - build_url:https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:31:14 INFO - Running post-action listener: _resource_record_post_action 06:31:14 INFO - Running post-action listener: set_extra_try_arguments 06:31:14 INFO - ##### 06:31:14 INFO - ##### Running populate-webroot step. 06:31:14 INFO - ##### 06:31:14 INFO - Running pre-action listener: _resource_record_pre_action 06:31:14 INFO - Running main action method: populate_webroot 06:31:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:31:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:31:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:31:14 INFO - '--tppagecycles', 06:31:14 INFO - '7'], 06:31:14 INFO - 'tests': ['tsvgm']}}, 06:31:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:31:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:31:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:31:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:31:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:14 INFO - 'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:14 INFO - 'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['damp', 'tps']}, 06:31:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:14 INFO - 'tests': ['damp', 'tps']}, 06:31:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['dromaeo_dom']}, 06:31:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:31:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['a11yr', 06:31:14 INFO - 'ts_paint', 06:31:14 INFO - 'tpaint', 06:31:14 INFO - 'sessionrestore', 06:31:14 INFO - 'sessionrestore_no_auto_restore', 06:31:14 INFO - 'tabpaint']}, 06:31:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:31:14 INFO - 'ts_paint', 06:31:14 INFO - 'tpaint', 06:31:14 INFO - 'sessionrestore', 06:31:14 INFO - 'sessionrestore_no_auto_restore', 06:31:14 INFO - 'tabpaint']}, 06:31:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:31:14 INFO - 'ts_paint', 06:31:14 INFO - 'tpaint', 06:31:14 INFO - 'sessionrestore', 06:31:14 INFO - 'sessionrestore_no_auto_restore', 06:31:14 INFO - 'tabpaint']}, 06:31:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:31:14 INFO - 'ts_paint', 06:31:14 INFO - 'tpaint', 06:31:14 INFO - 'sessionrestore', 06:31:14 INFO - 'sessionrestore_no_auto_restore', 06:31:14 INFO - 'tabpaint']}, 06:31:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['a11yr', 06:31:14 INFO - 'ts_paint', 06:31:14 INFO - 'tpaint', 06:31:14 INFO - 'sessionrestore', 06:31:14 INFO - 'sessionrestore_no_auto_restore', 06:31:14 INFO - 'tabpaint']}, 06:31:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['a11yr', 06:31:14 INFO - 'ts_paint', 06:31:14 INFO - 'tpaint', 06:31:14 INFO - 'sessionrestore', 06:31:14 INFO - 'sessionrestore_no_auto_restore', 06:31:14 INFO - 'tabpaint']}, 06:31:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['tsvgx', 06:31:14 INFO - 'tsvgr_opacity', 06:31:14 INFO - 'tart', 06:31:14 INFO - 'tscrollx', 06:31:14 INFO - 'cart']}, 06:31:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:31:14 INFO - 'tsvgr_opacity', 06:31:14 INFO - 'tart', 06:31:14 INFO - 'tscrollx', 06:31:14 INFO - 'cart']}, 06:31:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:14 INFO - 'talos_options': ['--disable-e10s'], 06:31:14 INFO - 'tests': ['tp5o']}, 06:31:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:14 INFO - 'tests': ['tp5o']}, 06:31:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:14 INFO - 'talos_options': ['--disable-e10s', 06:31:14 INFO - '--xperf_path', 06:31:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:14 INFO - 'tests': ['tp5n']}, 06:31:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:14 INFO - 'talos_options': ['--xperf_path', 06:31:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:14 INFO - 'tests': ['tp5n']}}, 06:31:14 INFO - 'talos.zip': {'path': '', 06:31:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:31:14 INFO - Running post-action listener: _resource_record_post_action 06:31:14 INFO - ##### 06:31:14 INFO - ##### Running create-virtualenv step. 06:31:14 INFO - ##### 06:31:14 INFO - Running pre-action listener: _resource_record_pre_action 06:31:14 INFO - Running main action method: create_virtualenv 06:31:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:31:14 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 06:31:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:31:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:31:14 INFO - Using real prefix '/usr' 06:31:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:31:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:31:17 INFO - Installing pip.................done. 06:31:17 INFO - Return code: 0 06:31:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:17 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:17 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 06:31:17 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 06:31:17 INFO - Using env: {'DISPLAY': ':0', 06:31:17 INFO - 'HOME': '/home/cltbld', 06:31:17 INFO - 'LANG': 'en_US.UTF-8', 06:31:17 INFO - 'LANGUAGE': 'en_US:en', 06:31:17 INFO - 'LOGNAME': 'cltbld', 06:31:17 INFO - 'MAIL': '/var/mail/cltbld', 06:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:17 INFO - 'MOZ_NO_REMOTE': '1', 06:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:17 INFO - 'NO_EM_RESTART': '1', 06:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:17 INFO - 'PWD': '/builds/slave/test', 06:31:17 INFO - 'SHELL': '/bin/bash', 06:31:17 INFO - 'SHLVL': '1', 06:31:17 INFO - 'TERM': 'linux', 06:31:17 INFO - 'TMOUT': '86400', 06:31:17 INFO - 'USER': 'cltbld', 06:31:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:17 INFO - '_': '/tools/buildbot/bin/python'} 06:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:17 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 06:31:17 INFO - Cleaning up... 06:31:17 INFO - Return code: 0 06:31:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:17 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:17 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 06:31:17 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 06:31:17 INFO - Using env: {'DISPLAY': ':0', 06:31:17 INFO - 'HOME': '/home/cltbld', 06:31:17 INFO - 'LANG': 'en_US.UTF-8', 06:31:17 INFO - 'LANGUAGE': 'en_US:en', 06:31:17 INFO - 'LOGNAME': 'cltbld', 06:31:17 INFO - 'MAIL': '/var/mail/cltbld', 06:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:17 INFO - 'MOZ_NO_REMOTE': '1', 06:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:17 INFO - 'NO_EM_RESTART': '1', 06:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:17 INFO - 'PWD': '/builds/slave/test', 06:31:17 INFO - 'SHELL': '/bin/bash', 06:31:17 INFO - 'SHLVL': '1', 06:31:17 INFO - 'TERM': 'linux', 06:31:17 INFO - 'TMOUT': '86400', 06:31:17 INFO - 'USER': 'cltbld', 06:31:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:17 INFO - '_': '/tools/buildbot/bin/python'} 06:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:17 INFO - Downloading/unpacking psutil>=0.7.1 06:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:31:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:19 INFO - Installing collected packages: psutil 06:31:19 INFO - Running setup.py install for psutil 06:31:19 INFO - building 'psutil._psutil_linux' extension 06:31:19 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 06:31:19 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 06:31:19 INFO - building 'psutil._psutil_posix' extension 06:31:19 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 06:31:19 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 06:31:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:20 INFO - Successfully installed psutil 06:31:20 INFO - Cleaning up... 06:31:20 INFO - Return code: 0 06:31:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:31:20 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')]} 06:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:20 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')]} 06:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:20 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:20 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 06:31:20 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 06:31:20 INFO - Using env: {'DISPLAY': ':0', 06:31:20 INFO - 'HOME': '/home/cltbld', 06:31:20 INFO - 'LANG': 'en_US.UTF-8', 06:31:20 INFO - 'LANGUAGE': 'en_US:en', 06:31:20 INFO - 'LOGNAME': 'cltbld', 06:31:20 INFO - 'MAIL': '/var/mail/cltbld', 06:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:20 INFO - 'MOZ_NO_REMOTE': '1', 06:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:20 INFO - 'NO_EM_RESTART': '1', 06:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:20 INFO - 'PWD': '/builds/slave/test', 06:31:20 INFO - 'SHELL': '/bin/bash', 06:31:20 INFO - 'SHLVL': '1', 06:31:20 INFO - 'TERM': 'linux', 06:31:20 INFO - 'TMOUT': '86400', 06:31:20 INFO - 'USER': 'cltbld', 06:31:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:20 INFO - '_': '/tools/buildbot/bin/python'} 06:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:31:20 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 06:31:20 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 06:31:20 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 06:31:20 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 06:31:20 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 06:31:20 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 06:31:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:31:22 INFO - Installing collected packages: mozsystemmonitor 06:31:22 INFO - Running setup.py install for mozsystemmonitor 06:31:22 INFO - Successfully installed mozsystemmonitor 06:31:22 INFO - Cleaning up... 06:31:22 INFO - Return code: 0 06:31:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:31:22 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')]} 06:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:22 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')]} 06:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:22 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:22 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 06:31:22 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 06:31:22 INFO - Using env: {'DISPLAY': ':0', 06:31:22 INFO - 'HOME': '/home/cltbld', 06:31:22 INFO - 'LANG': 'en_US.UTF-8', 06:31:22 INFO - 'LANGUAGE': 'en_US:en', 06:31:22 INFO - 'LOGNAME': 'cltbld', 06:31:22 INFO - 'MAIL': '/var/mail/cltbld', 06:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:22 INFO - 'MOZ_NO_REMOTE': '1', 06:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:22 INFO - 'NO_EM_RESTART': '1', 06:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:22 INFO - 'PWD': '/builds/slave/test', 06:31:22 INFO - 'SHELL': '/bin/bash', 06:31:22 INFO - 'SHLVL': '1', 06:31:22 INFO - 'TERM': 'linux', 06:31:22 INFO - 'TMOUT': '86400', 06:31:22 INFO - 'USER': 'cltbld', 06:31:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:22 INFO - '_': '/tools/buildbot/bin/python'} 06:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:22 INFO - Downloading/unpacking blobuploader==1.2.4 06:31:22 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 06:31:22 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 06:31:22 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 06:31:22 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 06:31:22 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 06:31:22 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 06:31:24 INFO - Downloading blobuploader-1.2.4.tar.gz 06:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:31:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:31:24 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 06:31:24 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 06:31:24 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 06:31:24 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 06:31:24 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 06:31:24 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 06:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:31:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:31:24 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 06:31:24 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 06:31:24 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 06:31:24 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 06:31:24 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 06:31:24 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 06:31:25 INFO - Downloading docopt-0.6.1.tar.gz 06:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:31:25 INFO - Installing collected packages: blobuploader, requests, docopt 06:31:25 INFO - Running setup.py install for blobuploader 06:31:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:31:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:31:25 INFO - Running setup.py install for requests 06:31:25 INFO - Running setup.py install for docopt 06:31:25 INFO - Successfully installed blobuploader requests docopt 06:31:25 INFO - Cleaning up... 06:31:25 INFO - Return code: 0 06:31:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:25 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')]} 06:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:25 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')]} 06:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:25 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:25 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 06:31:25 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 06:31:25 INFO - Using env: {'DISPLAY': ':0', 06:31:25 INFO - 'HOME': '/home/cltbld', 06:31:25 INFO - 'LANG': 'en_US.UTF-8', 06:31:25 INFO - 'LANGUAGE': 'en_US:en', 06:31:25 INFO - 'LOGNAME': 'cltbld', 06:31:25 INFO - 'MAIL': '/var/mail/cltbld', 06:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:25 INFO - 'MOZ_NO_REMOTE': '1', 06:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:25 INFO - 'NO_EM_RESTART': '1', 06:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:25 INFO - 'PWD': '/builds/slave/test', 06:31:25 INFO - 'SHELL': '/bin/bash', 06:31:25 INFO - 'SHLVL': '1', 06:31:25 INFO - 'TERM': 'linux', 06:31:25 INFO - 'TMOUT': '86400', 06:31:25 INFO - 'USER': 'cltbld', 06:31:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:25 INFO - '_': '/tools/buildbot/bin/python'} 06:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:26 INFO - Running setup.py (path:/tmp/pip-BmOu8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:26 INFO - Running setup.py (path:/tmp/pip-vvsCvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:26 INFO - Running setup.py (path:/tmp/pip-LFjfzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:26 INFO - Running setup.py (path:/tmp/pip-s4gj8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:26 INFO - Running setup.py (path:/tmp/pip-9CqQ22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:26 INFO - Running setup.py (path:/tmp/pip-vwFPV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:26 INFO - Running setup.py (path:/tmp/pip-EGwkMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:26 INFO - Running setup.py (path:/tmp/pip-TC4Hsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:26 INFO - Running setup.py (path:/tmp/pip-sVuXZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:26 INFO - Running setup.py (path:/tmp/pip-8npA_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:26 INFO - Running setup.py (path:/tmp/pip-xolf35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:26 INFO - Running setup.py (path:/tmp/pip-1PANGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:26 INFO - Running setup.py (path:/tmp/pip-_LS6Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:27 INFO - Running setup.py (path:/tmp/pip-0QRBJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:27 INFO - Running setup.py (path:/tmp/pip-9EgPZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:27 INFO - Running setup.py (path:/tmp/pip-J5u8ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:27 INFO - Running setup.py (path:/tmp/pip-whEXKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:31:27 INFO - Running setup.py install for manifestparser 06:31:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:31:27 INFO - Running setup.py install for mozcrash 06:31:27 INFO - Running setup.py install for mozdebug 06:31:27 INFO - Running setup.py install for mozdevice 06:31:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:31:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:31:27 INFO - Running setup.py install for mozfile 06:31:27 INFO - Running setup.py install for mozhttpd 06:31:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:31:27 INFO - Running setup.py install for mozinfo 06:31:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Running setup.py install for mozInstall 06:31:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Running setup.py install for mozleak 06:31:28 INFO - Running setup.py install for mozlog 06:31:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Running setup.py install for moznetwork 06:31:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Running setup.py install for mozprocess 06:31:28 INFO - Running setup.py install for mozprofile 06:31:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Running setup.py install for mozrunner 06:31:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:31:28 INFO - Running setup.py install for mozscreenshot 06:31:28 INFO - Running setup.py install for moztest 06:31:28 INFO - Running setup.py install for mozversion 06:31:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:31:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:31:29 INFO - Cleaning up... 06:31:29 INFO - Return code: 0 06:31:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:29 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:29 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 06:31:29 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 06:31:29 INFO - Using env: {'DISPLAY': ':0', 06:31:29 INFO - 'HOME': '/home/cltbld', 06:31:29 INFO - 'LANG': 'en_US.UTF-8', 06:31:29 INFO - 'LANGUAGE': 'en_US:en', 06:31:29 INFO - 'LOGNAME': 'cltbld', 06:31:29 INFO - 'MAIL': '/var/mail/cltbld', 06:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:29 INFO - 'MOZ_NO_REMOTE': '1', 06:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:29 INFO - 'NO_EM_RESTART': '1', 06:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:29 INFO - 'PWD': '/builds/slave/test', 06:31:29 INFO - 'SHELL': '/bin/bash', 06:31:29 INFO - 'SHLVL': '1', 06:31:29 INFO - 'TERM': 'linux', 06:31:29 INFO - 'TMOUT': '86400', 06:31:29 INFO - 'USER': 'cltbld', 06:31:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:29 INFO - '_': '/tools/buildbot/bin/python'} 06:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:29 INFO - Running setup.py (path:/tmp/pip-XxQ45L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:29 INFO - Running setup.py (path:/tmp/pip-ioQ2FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:29 INFO - Running setup.py (path:/tmp/pip-UGouUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:29 INFO - Running setup.py (path:/tmp/pip-4XP2Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:29 INFO - Running setup.py (path:/tmp/pip-UN7nee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:29 INFO - Running setup.py (path:/tmp/pip-pbHjEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:29 INFO - Running setup.py (path:/tmp/pip-W481QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:29 INFO - Running setup.py (path:/tmp/pip-pYPtn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:29 INFO - Running setup.py (path:/tmp/pip-CDRfPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:29 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)) 06:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:29 INFO - Running setup.py (path:/tmp/pip-ajTG8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:30 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)) 06:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:30 INFO - Running setup.py (path:/tmp/pip-jAlU3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:30 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)) 06:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:30 INFO - Running setup.py (path:/tmp/pip-5qMLBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:30 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)) 06:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:30 INFO - Running setup.py (path:/tmp/pip-g_fzjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:30 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)) 06:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:30 INFO - Running setup.py (path:/tmp/pip-m3P9jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:30 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)) 06:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:30 INFO - Running setup.py (path:/tmp/pip-CU1DKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:30 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)) 06:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:30 INFO - Running setup.py (path:/tmp/pip-fFn1ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:30 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)) 06:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:30 INFO - Running setup.py (path:/tmp/pip-CCqWdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:30 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)) 06:31:30 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)) 06:31:30 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)) 06:31:30 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)) 06:31:30 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)) 06:31:30 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)) 06:31:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:31:30 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 06:31:30 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 06:31:30 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 06:31:30 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 06:31:30 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 06:31:30 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 06:31:32 INFO - Downloading blessings-1.6.tar.gz 06:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:31:32 INFO - Installing collected packages: blessings 06:31:32 INFO - Running setup.py install for blessings 06:31:32 INFO - Successfully installed blessings 06:31:32 INFO - Cleaning up... 06:31:32 INFO - Return code: 0 06:31:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:31:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:32 INFO - Reading from file tmpfile_stdout 06:31:32 INFO - Current package versions: 06:31:32 INFO - argparse == 1.2.1 06:31:32 INFO - blessings == 1.6 06:31:32 INFO - blobuploader == 1.2.4 06:31:32 INFO - docopt == 0.6.1 06:31:32 INFO - manifestparser == 1.1 06:31:32 INFO - mozInstall == 1.12 06:31:32 INFO - mozcrash == 0.17 06:31:32 INFO - mozdebug == 0.1 06:31:32 INFO - mozdevice == 0.48 06:31:32 INFO - mozfile == 1.2 06:31:32 INFO - mozhttpd == 0.7 06:31:32 INFO - mozinfo == 0.9 06:31:32 INFO - mozleak == 0.1 06:31:32 INFO - mozlog == 3.1 06:31:32 INFO - moznetwork == 0.27 06:31:32 INFO - mozprocess == 0.22 06:31:32 INFO - mozprofile == 0.28 06:31:32 INFO - mozrunner == 6.11 06:31:32 INFO - mozscreenshot == 0.1 06:31:32 INFO - mozsystemmonitor == 0.0 06:31:32 INFO - moztest == 0.7 06:31:32 INFO - mozversion == 1.4 06:31:32 INFO - psutil == 3.1.1 06:31:32 INFO - requests == 1.2.3 06:31:32 INFO - wsgiref == 0.1.2 06:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:32 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')]} 06:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:32 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')]} 06:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:32 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:32 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 06:31:32 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 06:31:32 INFO - Using env: {'DISPLAY': ':0', 06:31:32 INFO - 'HOME': '/home/cltbld', 06:31:32 INFO - 'LANG': 'en_US.UTF-8', 06:31:32 INFO - 'LANGUAGE': 'en_US:en', 06:31:32 INFO - 'LOGNAME': 'cltbld', 06:31:32 INFO - 'MAIL': '/var/mail/cltbld', 06:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:32 INFO - 'MOZ_NO_REMOTE': '1', 06:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:32 INFO - 'NO_EM_RESTART': '1', 06:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:32 INFO - 'PWD': '/builds/slave/test', 06:31:32 INFO - 'SHELL': '/bin/bash', 06:31:32 INFO - 'SHLVL': '1', 06:31:32 INFO - 'TERM': 'linux', 06:31:32 INFO - 'TMOUT': '86400', 06:31:32 INFO - 'USER': 'cltbld', 06:31:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:32 INFO - '_': '/tools/buildbot/bin/python'} 06:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 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)) 06:31:33 INFO - Cleaning up... 06:31:33 INFO - Return code: 0 06:31:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:33 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:33 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 06:31:33 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 06:31:33 INFO - Using env: {'DISPLAY': ':0', 06:31:33 INFO - 'HOME': '/home/cltbld', 06:31:33 INFO - 'LANG': 'en_US.UTF-8', 06:31:33 INFO - 'LANGUAGE': 'en_US:en', 06:31:33 INFO - 'LOGNAME': 'cltbld', 06:31:33 INFO - 'MAIL': '/var/mail/cltbld', 06:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:33 INFO - 'MOZ_NO_REMOTE': '1', 06:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:33 INFO - 'NO_EM_RESTART': '1', 06:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:33 INFO - 'PWD': '/builds/slave/test', 06:31:33 INFO - 'SHELL': '/bin/bash', 06:31:33 INFO - 'SHLVL': '1', 06:31:33 INFO - 'TERM': 'linux', 06:31:33 INFO - 'TMOUT': '86400', 06:31:33 INFO - 'USER': 'cltbld', 06:31:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:33 INFO - '_': '/tools/buildbot/bin/python'} 06:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:33 INFO - Downloading/unpacking jsonschema 06:31:33 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 06:31:33 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 06:31:33 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 06:31:33 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 06:31:33 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 06:31:33 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 06:31:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:31:35 INFO - Downloading/unpacking functools32 (from jsonschema) 06:31:35 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 06:31:35 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 06:31:35 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 06:31:35 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 06:31:35 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 06:31:35 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 06:31:35 INFO - Downloading functools32-3.2.3-2.tar.gz 06:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:31:35 INFO - warning: no files found matching '*.txt' 06:31:35 INFO - no previously-included directories found matching 'build' 06:31:35 INFO - no previously-included directories found matching 'dist' 06:31:35 INFO - no previously-included directories found matching '.git*' 06:31:35 INFO - Installing collected packages: jsonschema, functools32 06:31:35 INFO - Running setup.py install for functools32 06:31:35 INFO - warning: no files found matching '*.txt' 06:31:35 INFO - no previously-included directories found matching 'build' 06:31:35 INFO - no previously-included directories found matching 'dist' 06:31:35 INFO - no previously-included directories found matching '.git*' 06:31:35 INFO - Successfully installed jsonschema functools32 06:31:35 INFO - Cleaning up... 06:31:35 INFO - Return code: 0 06:31:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:35 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 0x7f9a437e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', '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 06:31:35 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 06:31:35 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 06:31:35 INFO - Using env: {'DISPLAY': ':0', 06:31:35 INFO - 'HOME': '/home/cltbld', 06:31:35 INFO - 'LANG': 'en_US.UTF-8', 06:31:35 INFO - 'LANGUAGE': 'en_US:en', 06:31:35 INFO - 'LOGNAME': 'cltbld', 06:31:35 INFO - 'MAIL': '/var/mail/cltbld', 06:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:35 INFO - 'MOZ_NO_REMOTE': '1', 06:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:35 INFO - 'NO_EM_RESTART': '1', 06:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:35 INFO - 'PWD': '/builds/slave/test', 06:31:35 INFO - 'SHELL': '/bin/bash', 06:31:35 INFO - 'SHLVL': '1', 06:31:35 INFO - 'TERM': 'linux', 06:31:35 INFO - 'TMOUT': '86400', 06:31:35 INFO - 'USER': 'cltbld', 06:31:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:35 INFO - '_': '/tools/buildbot/bin/python'} 06:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:35 INFO - Downloading/unpacking flake8 06:31:35 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 06:31:35 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 06:31:35 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 06:31:35 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 06:31:35 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 06:31:35 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 06:31:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:31:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:31:37 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 06:31:37 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 06:31:37 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 06:31:37 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 06:31:37 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 06:31:37 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 06:31:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:31:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:31:37 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 06:31:37 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 06:31:37 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 06:31:37 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 06:31:37 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 06:31:37 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 06:31:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:31:38 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 06:31:38 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 06:31:38 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 06:31:38 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 06:31:38 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 06:31:38 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 06:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:31:38 INFO - no previously-included directories found matching 'docs/_build' 06:31:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:31:38 INFO - Running setup.py install for pep8 06:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:31:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:31:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:31:38 INFO - no previously-included directories found matching 'docs/_build' 06:31:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:31:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:31:38 INFO - Cleaning up... 06:31:38 INFO - Return code: 0 06:31:38 INFO - Running post-action listener: _resource_record_post_action 06:31:38 INFO - Running post-action listener: _start_resource_monitoring 06:31:38 INFO - Starting resource monitoring. 06:31:38 INFO - ##### 06:31:38 INFO - ##### Running install step. 06:31:38 INFO - ##### 06:31:38 INFO - Running pre-action listener: _resource_record_pre_action 06:31:38 INFO - Running main action method: install 06:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:38 INFO - Reading from file tmpfile_stdout 06:31:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:31:38 INFO - Reading from file tmpfile_stdout 06:31:38 INFO - Output received: 06:31:38 INFO - Usage: mozinstall [options] installer 06:31:38 INFO - Options: 06:31:38 INFO - -h, --help show this help message and exit 06:31:38 INFO - -d DEST, --destination=DEST 06:31:38 INFO - Directory to install application into. [default: 06:31:38 INFO - "/builds/slave/test"] 06:31:38 INFO - --app=APP Application being installed. [default: firefox] 06:31:38 INFO - mkdir: /builds/slave/test/build/application 06:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:31:54 INFO - Reading from file tmpfile_stdout 06:31:54 INFO - Output received: 06:31:54 INFO - /builds/slave/test/build/application/firefox/firefox 06:31:54 INFO - Running post-action listener: _resource_record_post_action 06:31:54 INFO - ##### 06:31:54 INFO - ##### Running run-tests step. 06:31:54 INFO - ##### 06:31:54 INFO - Running pre-action listener: _resource_record_pre_action 06:31:54 INFO - Running main action method: run_tests 06:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:31:54 INFO - Python 2.7.3 06:31:54 INFO - Return code: 0 06:31:54 INFO - grabbing minidump binary from tooltool 06:31: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')]} 06:31:54 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 0x24e5410>, '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 0x24e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:31:54 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 06:31:54 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 06:31:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:31:54 INFO - Return code: 0 06:31:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:31:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:31:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:31:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:31:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:31:55 INFO - Return code: 0 06:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:31:55 INFO - Using env: {'DISPLAY': ':0', 06:31:55 INFO - 'HOME': '/home/cltbld', 06:31:55 INFO - 'LANG': 'en_US.UTF-8', 06:31:55 INFO - 'LANGUAGE': 'en_US:en', 06:31:55 INFO - 'LOGNAME': 'cltbld', 06:31:55 INFO - 'MAIL': '/var/mail/cltbld', 06:31:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:31:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:55 INFO - 'MOZ_NO_REMOTE': '1', 06:31:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:55 INFO - 'NO_EM_RESTART': '1', 06:31:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:55 INFO - 'PWD': '/builds/slave/test', 06:31:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:31:55 INFO - 'SHELL': '/bin/bash', 06:31:55 INFO - 'SHLVL': '1', 06:31:55 INFO - 'TERM': 'linux', 06:31:55 INFO - 'TMOUT': '86400', 06:31:55 INFO - 'USER': 'cltbld', 06:31:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413', 06:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:55 INFO - '_': '/tools/buildbot/bin/python'} 06:31:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:31:55 INFO - mozversion application_buildid: 20160415052445 06:31:55 INFO - mozversion application_changeset: 0260dd297a25b97b11dfa208c3d556cb7b62542c 06:31:55 INFO - mozversion application_display_name: Nightly 06:31:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:31:55 INFO - mozversion application_name: Firefox 06:31:55 INFO - mozversion application_remotingname: firefox 06:31:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:31:55 INFO - mozversion application_vendor: Mozilla 06:31:55 INFO - mozversion application_version: 48.0a1 06:31:55 INFO - mozversion platform_buildid: 20160415052445 06:31:55 INFO - mozversion platform_changeset: 0260dd297a25b97b11dfa208c3d556cb7b62542c 06:31:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:31:55 INFO - mozversion platform_version: 48.0a1 06:31:55 INFO - using testdate: 1460727115 06:31:55 INFO - actual date: 1460727115 06:31:55 INFO - starting webserver on 'localhost:38984' 06:31:55 INFO - SUITE-START | Running 2 tests 06:31:55 INFO - TEST-START | dromaeo_css 06:31:55 INFO - operating with platform_type : linux_ 06:31:55 INFO - Initialising browser for dromaeo_css test... 06:31:55 INFO - TEST-INFO | started process 18395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKE6W8B/profile http://localhost:38984/getInfo.html) 06:31:59 INFO - PROCESS | 18395 | 06:31:59 INFO - PROCESS | 18395 | (process:18463): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:32:00 INFO - PROCESS | 18395 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 06:32:00 INFO - PROCESS | 18395 | __metrics Screen width/height:1600/1200 06:32:00 INFO - PROCESS | 18395 | colorDepth:24 06:32:00 INFO - PROCESS | 18395 | Browser inner width/height: 1024/697 06:32:00 INFO - PROCESS | 18395 | __metrics 06:32:01 ERROR - PROCESS | 18395 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:32:02 INFO - TEST-INFO | 18395: exit 0 06:32:02 INFO - Browser initialized. 06:32:02 INFO - Running cycle 1/1 for dromaeo_css test... 06:32:02 INFO - TEST-INFO | started process 18514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKE6W8B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:04 INFO - PROCESS | 18514 | 06:32:04 INFO - PROCESS | 18514 | (process:18572): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:32:14 INFO - PROCESS | 18514 | RSS: Main: 164622336 06:32:14 INFO - PROCESS | 18514 | 06:33:03 INFO - PROCESS | 18514 | 1460727183956 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] 06:35:15 INFO - PROCESS | 18514 | Cycle 1(1): loaded http://localhost:38984/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38984/tests/dromaeo/cssquery-ext.html) 06:35:16 INFO - PROCESS | 18514 | RSS: Main: 168280064 06:35:16 INFO - PROCESS | 18514 | 06:38:18 INFO - PROCESS | 18514 | Cycle 1(1): loaded http://localhost:38984/tests/dromaeo/cssquery-ext.html (next: http://localhost:38984/tests/dromaeo/cssquery-jquery.html) 06:38:19 INFO - PROCESS | 18514 | RSS: Main: 165494784 06:38:19 INFO - PROCESS | 18514 | 06:41:21 INFO - PROCESS | 18514 | Cycle 1(1): loaded http://localhost:38984/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38984/tests/dromaeo/cssquery-mootools.html) 06:41:21 INFO - PROCESS | 18514 | RSS: Main: 166559744 06:41:21 INFO - PROCESS | 18514 | 06:44:23 INFO - PROCESS | 18514 | Cycle 1(1): loaded http://localhost:38984/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38984/tests/dromaeo/cssquery-prototype.html) 06:44:24 INFO - PROCESS | 18514 | RSS: Main: 164134912 06:44:24 INFO - PROCESS | 18514 | 06:47:26 INFO - PROCESS | 18514 | Cycle 1(1): loaded http://localhost:38984/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38984/tests/dromaeo/cssquery-yui.html) 06:47:27 INFO - PROCESS | 18514 | RSS: Main: 165314560 06:47:27 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | Cycle 1(1): loaded http://localhost:38984/tests/dromaeo/cssquery-yui.html (next: http://localhost:38984/tests/dromaeo/cssquery-dojo.html) 06:50:29 INFO - PROCESS | 18514 | RSS: Main: 167235584 06:50:29 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | __start_tp_report 06:50:29 INFO - PROCESS | 18514 | _x_x_mozilla_page_load 06:50:29 INFO - PROCESS | 18514 | _x_x_mozilla_page_load_details 06:50:29 INFO - PROCESS | 18514 | |i|pagename|runs| 06:50:29 INFO - PROCESS | 18514 | |0;dojo.html;2568.7816535594475;2645.3122188231055;2684.194741577526;2688.5698288273866;2699;4668.649851261152;4688.460827004891;4688.882777930554;4709.835155769549;4743.193657078296;4581.79381927814;4597.195490789107;4690.671652984292;4751.738654374008;4795.448523419807;4366.345048242765;4460.3309503574565;4463.174312752135;4465.776711164445;4471.396361491205;413.3295583420111;4313.913721725564;4339.88167550643;4379.5182529921685;4432.933505997413;4375.168717943612;4378.584034516716;4386.605205531486;4387.9561204387865;4413.16149931512;4130.690198235145;4470.396496472967;4479.440069991251;4490.326451032339;4520.864374068783;4252.149570085995;4297.35539669049;4320.222359975203;4339.652827773771;4354.172707185625;4601.493835678073;4619.353290539327;4642.048380082108;4671.159191345557;4702.3416721659;5049.722265275408;5053.36832895888;5092.10888094582;5094.439611642716;5114.820981265638;5103.770330335144;5104.872378190538;5105.5149760772665;5109.41241757199;5110.054639891595;4725.740084295397;4738.289256611536;4743.359646447754;4748.074125545486;4751.881202969884;4976.0794253063295;5114.002769459919;5183.3261675981885;5189.351331083614;5230.267762513251;4962.181240095344;4963.156263435225;4963.45402005779;4977.850664480072;5002.74986250686;4992.151334273182;5006.3992320921;5008.023435430056;5026.346574945233;5093.879346543755;4846.248831431134;5010.073136469765;5064.822731204464;5072.4673909239;5073.797048118107;4673.299005149255;5020.49795020495;5050.065737838511;5069;5102.158143906214;4270.295401258758;4323.913521729548;4324.502682191525;4328.931058686491;4369.781510924441;3574.749767516249;3665.1020499977144;3698.093966978108;3746.925061498809;3780.7920564368674;4413.7572433515825;4415.2935530315;4415.823367065345;4449;4455.955440445554;4871.80512779492;5131.1277082895995;5144.588432925357;5159.922601160985;5162.328897243335;4379.58393952574;4421.624161946271;4427.690061695715;4445.1998640245065;4464.732116073046;4494.191045611821;4511.481179664315;4522.525134860858;4523.140603285366;4556.7721613919175;4560.498345181961;4744.620430365631;4781.139394908881;4793.736344501016;4808.759562021885;4924.236743304794;4965.404151501699;4985;4996.675216111086;5004.574611158092;4616.561426664462;4668.015248584756;4685.273782563708;4697.577218050392;4706.882327941828;4814.975925120352;4878.048780487771;4930.038642464685;4974.303597496426;5033.672811267256;5084.949150508448;5111.05445492585;5113.821016264413;5117.2068329409;5134.255532947627;4968.850934471827;4981.42713587942;4983.900321993612;4992.425871024879;4995.400551933792;4720.386349774507;4910.631702622246;4942.925856112233;4976.5023497649945;5029.974850125726;4603.746793926366;4765.070811191785;4849.781759820887;4860.441049279378;4936.136176169084;4972.453030166606;4980.526849949249;4999.850004499871;5009.724465154306;5073.985202959497;4662.580367766917;4825.927611085766;4892.290617860462;4893.510648935078;4918.704877707349 06:50:29 INFO - PROCESS | 18514 | |1;ext.html;576.5474102829277;612.4855121697773;617.435046932057;637.1016866218632;641.3938827807724;32432.513512297304;33330.1667458313;33332.83333583332;33387.49918751221;33530.832345838266;36593.26813463729;37536.62463375366;37541.249175016485;37647.623523764756;37700.62299377012;7724.536527808335;7904.762857114267;7914.050313962332;7919.287264146225;7925.524468531907;7760.262775036363;7884.172161923001;7885.172056934025;7889.250521200477;7899;7845.764627061198;7872.448928575002;7929.9207007930045;7947.165547617504;7952.681892724284;7862.52824830512;7881.881771773428;7892.80267993299;7925.3263472604895;7941.761747147595;7722.382209423233;7737.806554836118;7850.528968261866;7866.449348545604;7869.724559640443;31833.681663183303;33891.32217355664;34475.13812154716;34484.65515344865;34630.13424664403;3056.847157642131;3147.3705258948303;3340.9832950835334;3620.4388319810473;3787.3182827091387;27050.188494345202;27382.315442113908;27437.86281068602;28314.150575482767;28433.28916777097;3363.899083027489;3364.730821534296;3365.713914317286;3402.914927126817;3429.2455659754814;187885;193186;193692;194372;194499.02750486298;33738.66261337404;35013.47479787805;56300.71849640726;57800;57800.132998005065;34112.65887341144;34220;34375.140621484665;34482.48276275858;34494.137646558534;13103.2138071716;13141.802872956914;13244.801327980089;13291.468341266434;13337.333133343294;10791.190660700478;10857.185711071701;10941.945290273497;10967.287126336763;11004.779904402027;8425.4944703318;8442.409031367868;8462.323014158976;8488.193621605938;8562.272206862363;3287.769856110049;3303.9504407433906;3362.4115779738936;3363.630000699921;3378.138574663494;912.2838571721167;917.3074328881652;974.8635191073255;989.678354534779;994.3188915592842;27829.721702783118;27896.581551276748;28446.573301400495;28848.567271490945;28931.42137157245;985.6599473181741;1012.1902478017556;1021.6168936648756;1053.8735351757684;1061.9893801062044;14862.256887155816;15226.233220601565;15420.383184672712;15527.146006969726;15712.764308535381;355000;355698;359071.81856362725;359517;360859;48307.75846120747;49347.50652493429;49517;49678;49874.501254986986;1205.9577914773117;1222.3338280637074;1262.678017105632;1262.8673989231;1272.2748033620746;24719.752802471747;25714.35714107162;26459.867700661373;26520;26523.204303870916;43396.13207735891;43429.78285108554;43575.78212108919;43785.56214437942;43794.56205437905;325391;327124;327127;327768;328722;25541.616875746506;25763.742362576882;26269.868650656623;26335.20994370172;26385.208443746717;41510;41663.58336416597;42139.15721685488;42334.36498452587;42806;36065.63934360623;36158.638413615525;36346.636533635385;36857.07857303589;37128.81435592805;36221.27557448889;36468.81765591155;36489.27021459503;36841;37257;31608.683913161494;35713;36377.27245455129;36388.27223455569;37165.81417092897;28532.85733571319;31912.458946555565;32157.35685286328;32291.51562726608;32419.35161296808;24785.1325203617;24811.25566233016;24895;24910.875445622656;25031 06:50:29 INFO - PROCESS | 18514 | |2;jquery.html;381.608850927799;382.5022602406288;384.8210582079333;387.4614286142263;392.42509723255426;15756.290966906488;16980;17141.228644711002;17622.207000684968;17765.378211762607;15361.30874110665;15794.84205157948;16164.676706465863;16230.188490575454;16266.593335166626;4988.725620090893;5152.407473140581;5184.844454666347;5189.455107213726;5197.714125723083;3621.674049335559;5568.916466253009;5904.911426328608;5906.911396329058;5909.586328956974;5625.099984002561;5834.183214349994;5848.795292164775;5849.181114643953;5878.588498805086;5824.534037277008;5838.824835254949;5863.208466856962;5885.146653735227;5890.263717035371;4537.546245375469;4890.951090489085;5164.2253661950635;5175.327207463006;5185;12571.685707857285;12601.180923240052;17265.741013884803;19069.809301906942;19441.902790485958;1810;1845.5017145370675;1908.475169328432;2022.6055919095782;2220.433789383697;8663.870041949376;8780.736577902673;9291.58187881547;9404.388714733588;9412.058794120534;1677.966440671192;1776.600264940391;1847.667419864424;1876.1088482970615;1881.4637828218893;63824;64882.35117648858;65563.34436655621;65811.341886581;66217.00674489935;9480.620775169054;9707.563159657833;10169.898301017043;10836.133109351233;10919.617813376493;14032.08791428554;14075.859241407456;14155.29223538819;14191.148531088167;14208.147511149364;6901.482388820858;7156.355927966404;7226.168990566047;7387.7783666490095;7462.08978498386;6765.830854228585;6798.5241033128195;6896.172459304916;6922.203946546111;6983.8603227935155;4350.151720414552;4389.846355377546;4433.7118087324225;4464.352668862996;4542.091581683677;1739.5738044179257;1807.466797294775;1921.423572928116;1925.1433112265188;1953.4530331506917;832.3632421197789;878.2052242720348;913.0413066280379;953.580424613168;976.5068640336584;15783.842161578466;16378.181090945405;16585.50243492697;16650.417235396944;16841.242144103544;829.8547754143121;851.8722191671175;874.7332063720627;900;970.0445061614304;9129.315301352424;9135.634574617074;9151.771205719777;9474.147326740627;9552.856707149398;381602;395132.3894088466;399785;410462;411707;79352.60323698344;82027;82115.58942205251;82175.5891220552;82677.58661206656;938.4697645830221;945.7541039329824;960.3373672166183;980.0493521284343;980.2305190425624;14547.636309092357;14710.779338310149;14721.705565888837;14736;14787.778183327044;31752.841235793672;32419.082282594678;33251.33497329991;34284.65715342815;34520.30959380849;44783.77608111939;44818;45523.08953820839;45535.31697024614;45548;7400.629968501661;7497.737579184921;7526.720457522344;7599.936008958861;7650.693972241048;10281.897181028095;11367.374794386387;11619.244749091282;11676.124290678403;11676.824847627462;9596.808063838824;9656.970553404963;9754.707358779247;9813.803723925339;9965.950170249102;9849.852252216078;9992.15066719337;10035.849462257926;10220.233482488695;10289.639862604772;9435.961730771958;9659.32384733062;9742.561584728846;10309.432981186106;10530.736731581464;7625.466217364731;7724.884126738216;7728.574928378768;7782.44351129765;7864.056313242448;9277.86083208766;9837.60649574009;9902.752431189278;9926.15627671656;10202.132818710195 06:50:29 INFO - PROCESS | 18514 | |3;mootools.html;1437.0228244793539;1468.8898332625051;1601.8077830660322;1708.957276068099;1771.0613374911302;6830.077939478169;7714.6914123435;7887.763367098996;7983.600819959001;8001.279884810366;7910.762677119696;7919.881201781978;7921.445498815086;7995.360371170307;8015.879761803578;2225.121077174515;2237.407087121906;2254.0870947266385;2257.1535674122206;2265.0713207584813;2189.1681161158735;2210.668399740036;2257.5146343536135;2257.582347265753;2263.026898433673;2225.7551669316445;2259.1302348595746;2264.9660255096187;2281.7147856517936;2304.28567144185;2216.6674998750154;2216.8780717060554;2220.7002054722648;2224.3215819175143;2228.799408053283;2179.193698331612;2197.2968650031994;2216.966745498819;2218.0351547077075;2219.889005549716;8058.073321568036;8058.315043221333;8125.674973001072;8126.959365203136;8142.837143257161;4515.571020753023;4681.438227412732;4683.391159149289;4705.082508910764;4709.740964246965;2793.511135551291;2938.9118326450025;2939.088882446427;2942.970570294291;2977.8511074446405;950.2872845365976;955.2310390135938;959.640134949394;977.3207620703614;996.6063404955003;10779.78440431187;10888;10892.455377231028;10900.07349375304;10904.781904361947;4152.148809494047;4236.195122926696;4304.612584867315;4371.060222052274;4404.273294906368;9298.581563829644;9310.953445232866;9317.301202409846;9318.207952324128;9336.11306925841;4697.647676424282;4711.45818230901;4722.433308003062;4726.26742854858;4733.739644319596;3759.812009399519;4128.690348223895;4210;4279.165562715303;4305.375720520569;3746.8126593670754;3799.5820459749407;3824.29250588642;3875.748076375027;3886.6696330812197;1215.4469716279248;1222.0895432902366;1224.8591411987557;1237.9257244565356;1238.795598726218;760.9923900760922;865.446114486729;869.6347534035593;874.07784787049;890.4657205676672;5312.628116031918;5423.186522021729;5465.9180112298345;5496.780128794803;5569.415211402826;423.2445085522389;425.9403683484315;428.18858263590323;923.4413180026122;935.6631612619451;3531.8763843265874;3633.527641406653;3689.5572531296416;3696.2607478504406;3722.9813850930573;9924.354916930377;10181.694549163536;10246.180305575535;10352.896471035343;10383.013613706686;9959.850602240973;10121.645742398981;10128.848067278997;10140.391576505433;10177.33847299938;7023.403010744144;7058.752943646948;7215.314545118205;7235.89146162808;7237.203907570163;5253.553447956967;5277;5303.814366497154;5340.679559226459;5345.1714984177515;9070.727878163665;9332.860007099764;9364.250859931053;9421.104995025462;9435.575399107194;9159.954200229222;9291.907080929375;9496.715098547054;9543.236541076836;9573.18627916635;5812.418758124154;6386.361363863576;6427.55007149495;6477.481801455967;6599.505037122139;7789.766307010798;7797.532148071134;7810.765677029698;7835.608219589112;7836.412269079956;6917.619530925847;7144.1784194818265;7156.928430715626;7182.138143422822;7225.5664660120565;7008.7546935857;7015.579065256101;7035.753748618774;7131.8573628528175;7146.964265178641;6127.479164271087;6347.619142851444;6353.047042943595;6374.107624932421;6568.408843204134;4442.267025940683;4548.295014272793;4556.567126123013;4596.5863072323655;4628.768561571976;4576.519465456079;4653.557911998355;4680.625549956064;4694.671373003857;4729.148753224453 06:50:29 INFO - PROCESS | 18514 | |4;prototype.html;315.3409374407488;320.9374172036452;324.8002478475738;326.36521964778507;328.3580599927143;4820.301056346828;5351.759170837312;5378.633401303424;5433.18502224666;5433.701146436944;5360.678359298445;5362.410134885169;5365.248865158881;5365.490278423554;5399;4185.497740271172;4198.160367926412;4202.348635961431;4203.537610862811;4203.621674049335;3904;4215.536291008002;4218.493780746315;4220;4232.195882782277;4075;4093.6520395766397;4094.303968325377;4094.815733291994;4098.8565400211;4083.7958102094926;4107.732997355177;4121.979390103061;4125.855595054189;4137.627613514768;3451.913702157441;3586.5696116466193;3588.5693716753894;3599.3881040223223;3599.6681227945564;5137.998090372379;5154.381474223117;5166.560842328407;5170.784865556591;5177.326947496801;4670.929936050962;4673.055974735895;4710.434747830248;4736.218523943545;4764;5480.534154596864;5585.022621041301;5588.580856435784;5614.63504872182;5637.802676906289;3823.7896915669626;3860.3823388257742;3866.8066596670337;3872.5933776953298;3872.7676339419727;5588.385277619459;5722.227499287585;5886.764529418818;5904.675242861641;5934.6142500737315;4005.959940400617;4008.4588580541254;4011.4584531088512;4015.2170326785995;4023.456833327522;4018.778967156776;4071.185762847442;4088.1619268049976;4093.2427500912427;4102.138550904344;4573.405457290531;4642.2340313847835;4668.089722504147;4681.133990211822;4684.461286951976;5618.061768689796;5624.128260119688;5633.0987042073075;5633.549316054706;5635.690037048002;1390.1520072755611;1417.588899219215;1424.2807382271887;1424.6936908564708;1431.9642008949859;916.6287653500343;932.3007744191856;949.2453499467939;959.8608201810838;965.4834663455018;4910.361652985089;4921.26181072842;4933.161362568372;4940.777665005012;4946.727929963887;5760.452756988079;5806.912896306559;5817.214676018683;5819.767209311664;5835.854103647443;4821.325014497973;4911.656184067152;4940.382452193476;4942.975285123552;4959.20652695567;3127.9061628151194;3134.138112019213;3139.968600314013;3142.2929840786096;3149.1969547765175;5421.430749771217;5434.782608695687;5474.616776825664;5495.313085864267;5509.512431643434;5760.3951585083805;5905.202797622352;5953.8742160366155;5957.582969192115;5975.342712301644;5401;5404.054290499225;5437.564994800407;5445.618806683573;5500.917486237629;5611.691356975405;5774.133879918046;5801.6519008859605;5822.184894114743;5828.329742079715;5687.630304030225;5698.202251684685;5704.573856535866;5710.086386178192;5723.65658060501;5208.348956380452;5301.6818990860675;5403.594730395157;5452.09176788121;5504.990678402434;3940.2907476654477;3947.309220886276;3956.208758248304;3970.1861118470065;3977.0455090778582;5806.332271788799;5847.795327163529;5856.297244330707;5902.852428689317;5905.734241959208;5464.726763661881;5634.52106570946;5651.858703532444;5672.12082127271;5672.517835983987;5630.4369563043365;5660.32076150848;5663.773449061991;5672.376038635829;5683.403242659627;5399.217113518596;5556.527695145796;5572.721363931868;5587.8882422352135;5591;5659.717014149359;5662.971685141712;5718.142278658234;5719.8570035749435;5720.599558031065;5577.219189313419;5582.972085139549;5593.216949626974;5606.103023516218;5607.186957891001 06:50:29 INFO - PROCESS | 18514 | |5;yui.html;673.9022841687959;681.8534015186734;681.9556728812628;701.9996504980402;736.8305289783351;11628.883711162896;12232.938835305822;12467.688307792298;12499.875001249984;13785.931070344659;13622.931885340584;13656.453741850339;13664.590062298123;13687.384067716952;13742.58772236832;654.4371840217409;831.085805613823;832.7418500264907;832.862577674686;837.2464781696461;800.7837883771407;828.1635548096406;828.7099515169673;829.1418381974657;829.531314807135;855.8159995600945;858.9226969572737;866.0906048648925;869.3914260017981;869.6651789061225;855.9572021398906;856.8500512410303;858.6651206029653;862.1421685422981;863.896332440105;619.5724949784634;621.561798931752;628.0516420205477;629.0187307799847;629.710333246707;12661.30362830044;12705.682357941034;12733.108682392236;12735.74528509434;12790.808137877939;12298.569550065704;12368;12411.875881241253;12553.686157846036;12784.6803829905;10246.436445995467;10280.845787313121;10341.586336546605;10578.894211057868;10643.361398316049;3256.495243237302;3334.3498017886523;3355.1947532592244;3363.024722830376;3367.96632033679;45505;45796.3130553042;46538.767306163594;46582.301265481045;47009.294860577116;9579.568919398644;9705.951470242604;9815.705528834147;10046.447445390573;10136.949315253376;16722.581935451468;17002.319907203822;17002.829971700125;17109.914450427666;17133.91433042827;6779.525433219627;6867.828304292432;6872.69072891721;7001.194862590867;7065.187503437068;3961.58403367648;4024.8188831502653;4029.778362190049;4036.616521430459;4071.6539094176733;2838.815476993989;2933.1640482462394;2935.515639919432;2940.5736168255485;2958.423107494018;531.6650510178563;535.9598030147677;539.3393093460479;543.0713479949252;547.1327945206813;551.1154596872043;577.8353169346716;584.4593750780512;622.9127922090911;641.6246495800009;7682.347000504908;8248.670053197924;8307.501549907025;8382.706605268786;8431.831363372698;576.3602699635659;600.1447936690199;623.8658688381929;628.3214128740949;629.222909706512;3444.534987776668;3511.877084302037;3575.4458059000895;3645.453182022665;3687.7049836013052;42813.571864281585;53502;54080.188797167284;54280.45719542833;54494.45505544894;43924.341134883005;43966.99999999936;44774.552254477036;44843;45384.54615453869;38770.224595507934;39703.40444893329;40204;40446;40514.39228411576;7666.923330766621;7966.920330796618;8118.3099436548555;8156.102828688958;8375.32997360222;27385.58921616217;27489;27783.44433111286;27859.582106268015;28169.859150704116;36940.81529592335;38032.80983595064;38140;38192.23615527729;38282.42576361301;10556.683299501028;10560.904707530704;10631.681049568217;10914.563417463212;10997.835032474679;11885.147564584611;11908.821367679666;11969.222000569935;11991.129415491649;12056.698582535506;10981.725456863642;11165.49755260999;11180.161487888277;11568.595099171489;11572.768544628892;11116.61091861781;11171.739098113161;11333.320000799979;11588.188826782045;11735.589254376397;11162.162837787037;11291.3789741565;11350.318980861175;11424.657260282205;11531.538738450368;9485.66800161991;9515.429074255568;9609.375390599589;9658.130768230892;9805.656802011896;9295.76760580991;9521.857172142561;9621.615135394786;9802.117809397188;9859.211263098792 06:50:29 INFO - PROCESS | 18514 | __end_tp_report 06:50:29 INFO - PROCESS | 18514 | __start_cc_report 06:50:29 INFO - PROCESS | 18514 | _x_x_mozilla_cycle_collect,365 06:50:29 INFO - PROCESS | 18514 | __end_cc_report 06:50:29 INFO - PROCESS | 18514 | __startTimestamp1460728229916__endTimestamp 06:50:29 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | ------- Summary: start ------- 06:50:29 INFO - PROCESS | 18514 | Number of tests: 6 06:50:29 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | [#0] dojo.html Cycles:165 Average:4647.19 Median:4748.07 stddev:586.78 (12.4%) stddev-sans-first:565.47 06:50:29 INFO - PROCESS | 18514 | Values: 2568.8 2645.3 2684.2 2688.6 2699.0 4668.6 4688.5 4688.9 4709.8 4743.2 4581.8 4597.2 4690.7 4751.7 4795.4 4366.3 4460.3 4463.2 4465.8 4471.4 413.3 4313.9 4339.9 4379.5 4432.9 4375.2 4378.6 4386.6 4388.0 4413.2 4130.7 4470.4 4479.4 4490.3 4520.9 4252.1 4297.4 4320.2 4339.7 4354.2 4601.5 4619.4 4642.0 4671.2 4702.3 5049.7 5053.4 5092.1 5094.4 5114.8 5103.8 5104.9 5105.5 5109.4 5110.1 4725.7 4738.3 4743.4 4748.1 4751.9 4976.1 5114.0 5183.3 5189.4 5230.3 4962.2 4963.2 4963.5 4977.9 5002.7 4992.2 5006.4 5008.0 5026.3 5093.9 4846.2 5010.1 5064.8 5072.5 5073.8 4673.3 5020.5 5050.1 5069.0 5102.2 4270.3 4323.9 4324.5 4328.9 4369.8 3574.7 3665.1 3698.1 3746.9 3780.8 4413.8 4415.3 4415.8 4449.0 4456.0 4871.8 5131.1 5144.6 5159.9 5162.3 4379.6 4421.6 4427.7 4445.2 4464.7 4494.2 4511.5 4522.5 4523.1 4556.8 4560.5 4744.6 4781.1 4793.7 4808.8 4924.2 4965.4 4985.0 4996.7 5004.6 4616.6 4668.0 4685.3 4697.6 4706.9 4815.0 4878.0 4930.0 4974.3 5033.7 5084.9 5111.1 5113.8 5117.2 5134.3 4968.9 4981.4 4983.9 4992.4 4995.4 4720.4 4910.6 4942.9 4976.5 5030.0 4603.7 4765.1 4849.8 4860.4 4936.1 4972.5 4980.5 4999.9 5009.7 5074.0 4662.6 4825.9 4892.3 4893.5 4918.7 06:50:29 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | [#1] ext.html Cycles:180 Average:43732.34 Median:34483.57 stddev:79519.45 (230.6%) stddev-sans-first:79676.51 06:50:29 INFO - PROCESS | 18514 | Values: 576.5 612.5 617.4 637.1 641.4 32432.5 33330.2 33332.8 33387.5 33530.8 36593.3 37536.6 37541.2 37647.6 37700.6 7724.5 7904.8 7914.1 7919.3 7925.5 7760.3 7884.2 7885.2 7889.3 7899.0 7845.8 7872.4 7929.9 7947.2 7952.7 7862.5 7881.9 7892.8 7925.3 7941.8 7722.4 7737.8 7850.5 7866.4 7869.7 31833.7 33891.3 34475.1 34484.7 34630.1 3056.8 3147.4 3341.0 3620.4 3787.3 27050.2 27382.3 27437.9 28314.2 28433.3 3363.9 3364.7 3365.7 3402.9 3429.2 187885.0 193186.0 193692.0 194372.0 194499.0 33738.7 35013.5 56300.7 57800.0 57800.1 34112.7 34220.0 34375.1 34482.5 34494.1 13103.2 13141.8 13244.8 13291.5 13337.3 10791.2 10857.2 10941.9 10967.3 11004.8 8425.5 8442.4 8462.3 8488.2 8562.3 3287.8 3304.0 3362.4 3363.6 3378.1 912.3 917.3 974.9 989.7 994.3 27829.7 27896.6 28446.6 28848.6 28931.4 985.7 1012.2 1021.6 1053.9 1062.0 14862.3 15226.2 15420.4 15527.1 15712.8 355000.0 355698.0 359071.8 359517.0 360859.0 48307.8 49347.5 49517.0 49678.0 49874.5 1206.0 1222.3 1262.7 1262.9 1272.3 24719.8 25714.4 26459.9 26520.0 26523.2 43396.1 43429.8 43575.8 43785.6 43794.6 325391.0 327124.0 327127.0 327768.0 328722.0 25541.6 25763.7 26269.9 26335.2 26385.2 41510.0 41663.6 42139.2 42334.4 42806.0 36065.6 36158.6 36346.6 36857.1 37128.8 36221.3 36468.8 36489.3 36841.0 37257.0 31608.7 35713.0 36377.3 36388.3 37165.8 28532.9 31912.5 32157.4 32291.5 32419.4 24785.1 24811.3 24895.0 24910.9 25031.0 06:50:29 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | [#2] jquery.html Cycles:180 Average:24138.15 Median:5180.09 stddev:65952.10 (1273.2%) stddev-sans-first:66112.99 06:50:29 INFO - PROCESS | 18514 | Values: 381.6 382.5 384.8 387.5 392.4 15756.3 16980.0 17141.2 17622.2 17765.4 15361.3 15794.8 16164.7 16230.2 16266.6 4988.7 5152.4 5184.8 5189.5 5197.7 3621.7 5568.9 5904.9 5906.9 5909.6 5625.1 5834.2 5848.8 5849.2 5878.6 5824.5 5838.8 5863.2 5885.1 5890.3 4537.5 4891.0 5164.2 5175.3 5185.0 12571.7 12601.2 17265.7 19069.8 19441.9 1810.0 1845.5 1908.5 2022.6 2220.4 8663.9 8780.7 9291.6 9404.4 9412.1 1678.0 1776.6 1847.7 1876.1 1881.5 63824.0 64882.4 65563.3 65811.3 66217.0 9480.6 9707.6 10169.9 10836.1 10919.6 14032.1 14075.9 14155.3 14191.1 14208.1 6901.5 7156.4 7226.2 7387.8 7462.1 6765.8 6798.5 6896.2 6922.2 6983.9 4350.2 4389.8 4433.7 4464.4 4542.1 1739.6 1807.5 1921.4 1925.1 1953.5 832.4 878.2 913.0 953.6 976.5 15783.8 16378.2 16585.5 16650.4 16841.2 829.9 851.9 874.7 900.0 970.0 9129.3 9135.6 9151.8 9474.1 9552.9 381602.0 395132.4 399785.0 410462.0 411707.0 79352.6 82027.0 82115.6 82175.6 82677.6 938.5 945.8 960.3 980.0 980.2 14547.6 14710.8 14721.7 14736.0 14787.8 31752.8 32419.1 33251.3 34284.7 34520.3 44783.8 44818.0 45523.1 45535.3 45548.0 7400.6 7497.7 7526.7 7599.9 7650.7 10281.9 11367.4 11619.2 11676.1 11676.8 9596.8 9657.0 9754.7 9813.8 9966.0 9849.9 9992.2 10035.8 10220.2 10289.6 9436.0 9659.3 9742.6 10309.4 10530.7 7625.5 7724.9 7728.6 7782.4 7864.1 9277.9 9837.6 9902.8 9926.2 10202.1 06:50:29 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | [#3] mootools.html Cycles:180 Average:5263.40 Median:4710.60 stddev:2986.67 (63.4%) stddev-sans-first:2981.20 06:50:29 INFO - PROCESS | 18514 | Values: 1437.0 1468.9 1601.8 1709.0 1771.1 6830.1 7714.7 7887.8 7983.6 8001.3 7910.8 7919.9 7921.4 7995.4 8015.9 2225.1 2237.4 2254.1 2257.2 2265.1 2189.2 2210.7 2257.5 2257.6 2263.0 2225.8 2259.1 2265.0 2281.7 2304.3 2216.7 2216.9 2220.7 2224.3 2228.8 2179.2 2197.3 2217.0 2218.0 2219.9 8058.1 8058.3 8125.7 8127.0 8142.8 4515.6 4681.4 4683.4 4705.1 4709.7 2793.5 2938.9 2939.1 2943.0 2977.9 950.3 955.2 959.6 977.3 996.6 10779.8 10888.0 10892.5 10900.1 10904.8 4152.1 4236.2 4304.6 4371.1 4404.3 9298.6 9311.0 9317.3 9318.2 9336.1 4697.6 4711.5 4722.4 4726.3 4733.7 3759.8 4128.7 4210.0 4279.2 4305.4 3746.8 3799.6 3824.3 3875.7 3886.7 1215.4 1222.1 1224.9 1237.9 1238.8 761.0 865.4 869.6 874.1 890.5 5312.6 5423.2 5465.9 5496.8 5569.4 423.2 425.9 428.2 923.4 935.7 3531.9 3633.5 3689.6 3696.3 3723.0 9924.4 10181.7 10246.2 10352.9 10383.0 9959.9 10121.6 10128.8 10140.4 10177.3 7023.4 7058.8 7215.3 7235.9 7237.2 5253.6 5277.0 5303.8 5340.7 5345.2 9070.7 9332.9 9364.3 9421.1 9435.6 9160.0 9291.9 9496.7 9543.2 9573.2 5812.4 6386.4 6427.6 6477.5 6599.5 7789.8 7797.5 7810.8 7835.6 7836.4 6917.6 7144.2 7156.9 7182.1 7225.6 7008.8 7015.6 7035.8 7131.9 7147.0 6127.5 6347.6 6353.0 6374.1 6568.4 4442.3 4548.3 4556.6 4596.6 4628.8 4576.5 4653.6 4680.6 4694.7 4729.1 06:50:29 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | [#4] prototype.html Cycles:180 Average:4648.43 Median:5363.83 stddev:1370.15 (25.5%) stddev-sans-first:1334.84 06:50:29 INFO - PROCESS | 18514 | Values: 315.3 320.9 324.8 326.4 328.4 4820.3 5351.8 5378.6 5433.2 5433.7 5360.7 5362.4 5365.2 5365.5 5399.0 4185.5 4198.2 4202.3 4203.5 4203.6 3904.0 4215.5 4218.5 4220.0 4232.2 4075.0 4093.7 4094.3 4094.8 4098.9 4083.8 4107.7 4122.0 4125.9 4137.6 3451.9 3586.6 3588.6 3599.4 3599.7 5138.0 5154.4 5166.6 5170.8 5177.3 4670.9 4673.1 4710.4 4736.2 4764.0 5480.5 5585.0 5588.6 5614.6 5637.8 3823.8 3860.4 3866.8 3872.6 3872.8 5588.4 5722.2 5886.8 5904.7 5934.6 4006.0 4008.5 4011.5 4015.2 4023.5 4018.8 4071.2 4088.2 4093.2 4102.1 4573.4 4642.2 4668.1 4681.1 4684.5 5618.1 5624.1 5633.1 5633.5 5635.7 1390.2 1417.6 1424.3 1424.7 1432.0 916.6 932.3 949.2 959.9 965.5 4910.4 4921.3 4933.2 4940.8 4946.7 5760.5 5806.9 5817.2 5819.8 5835.9 4821.3 4911.7 4940.4 4943.0 4959.2 3127.9 3134.1 3140.0 3142.3 3149.2 5421.4 5434.8 5474.6 5495.3 5509.5 5760.4 5905.2 5953.9 5957.6 5975.3 5401.0 5404.1 5437.6 5445.6 5500.9 5611.7 5774.1 5801.7 5822.2 5828.3 5687.6 5698.2 5704.6 5710.1 5723.7 5208.3 5301.7 5403.6 5452.1 5505.0 3940.3 3947.3 3956.2 3970.2 3977.0 5806.3 5847.8 5856.3 5902.9 5905.7 5464.7 5634.5 5651.9 5672.1 5672.5 5630.4 5660.3 5663.8 5672.4 5683.4 5399.2 5556.5 5572.7 5587.9 5591.0 5659.7 5663.0 5718.1 5719.9 5720.6 5577.2 5583.0 5593.2 5606.1 5607.2 06:50:29 INFO - PROCESS | 18514 | 06:50:29 INFO - PROCESS | 18514 | [#5] yui.html Cycles:180 Average:12677.04 Median:22293.02 stddev:14057.07 (63.1%) stddev-sans-first:14067.60 06:50:29 INFO - PROCESS | 18514 | Values: 673.9 681.9 682.0 702.0 736.8 11628.9 12232.9 12467.7 12499.9 13785.9 13622.9 13656.5 13664.6 13687.4 13742.6 654.4 831.1 832.7 832.9 837.2 800.8 828.2 828.7 829.1 829.5 855.8 858.9 866.1 869.4 869.7 856.0 856.9 858.7 862.1 863.9 619.6 621.6 628.1 629.0 629.7 12661.3 12705.7 12733.1 12735.7 12790.8 12298.6 12368.0 12411.9 12553.7 12784.7 10246.4 10280.8 10341.6 10578.9 10643.4 3256.5 3334.3 3355.2 3363.0 3368.0 45505.0 45796.3 46538.8 46582.3 47009.3 9579.6 9706.0 9815.7 10046.4 10136.9 16722.6 17002.3 17002.8 17109.9 17133.9 6779.5 6867.8 6872.7 7001.2 7065.2 3961.6 4024.8 4029.8 4036.6 4071.7 2838.8 2933.2 2935.5 2940.6 2958.4 531.7 536.0 539.3 543.1 547.1 551.1 577.8 584.5 622.9 641.6 7682.3 8248.7 8307.5 8382.7 8431.8 576.4 600.1 623.9 628.3 629.2 3444.5 3511.9 3575.4 3645.5 3687.7 42813.6 53502.0 54080.2 54280.5 54494.5 43924.3 43967.0 44774.6 44843.0 45384.5 38770.2 39703.4 40204.0 40446.0 40514.4 7666.9 7966.9 8118.3 8156.1 8375.3 27385.6 27489.0 27783.4 27859.6 28169.9 36940.8 38032.8 38140.0 38192.2 38282.4 10556.7 10560.9 10631.7 10914.6 10997.8 11885.1 11908.8 11969.2 11991.1 12056.7 10981.7 11165.5 11180.2 11568.6 11572.8 11116.6 11171.7 11333.3 11588.2 11735.6 11162.2 11291.4 11350.3 11424.7 11531.5 9485.7 9515.4 9609.4 9658.1 9805.7 9295.8 9521.9 9621.6 9802.1 9859.2 06:50:29 INFO - PROCESS | 18514 | -------- Summary: end -------- 06:50:29 INFO - PROCESS | 18514 | 06:50:30 INFO - TEST-INFO | 18514: exit 0 06:50:30 INFO - TEST-OK | dromaeo_css | took 1114718ms 06:50:30 INFO - TEST-START | kraken 06:50:30 INFO - operating with platform_type : linux_ 06:50:30 INFO - Initialising browser for kraken test... 06:50:30 INFO - TEST-INFO | started process 18742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptgIk4A/profile http://localhost:38984/getInfo.html) 06:50:34 INFO - PROCESS | 18742 | 06:50:34 INFO - PROCESS | 18742 | (process:18808): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:50:34 INFO - PROCESS | 18742 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 06:50:35 INFO - PROCESS | 18742 | __metrics Screen width/height:1600/1200 06:50:35 INFO - PROCESS | 18742 | colorDepth:24 06:50:35 INFO - PROCESS | 18742 | Browser inner width/height: 1024/697 06:50:35 INFO - PROCESS | 18742 | __metrics 06:50:36 ERROR - PROCESS | 18742 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:50:36 INFO - TEST-INFO | 18742: exit 0 06:50:36 INFO - Browser initialized. 06:50:36 INFO - Running cycle 1/1 for kraken test... 06:50:36 INFO - TEST-INFO | started process 18859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptgIk4A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:38 INFO - PROCESS | 18859 | 06:50:38 INFO - PROCESS | 18859 | (process:18916): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:50:48 INFO - PROCESS | 18859 | RSS: Main: 164872192 06:50:48 INFO - PROCESS | 18859 | 06:50:51 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38984/tests/kraken/driver.html?testName=audio-beat-detection) 06:50:52 INFO - PROCESS | 18859 | RSS: Main: 169070592 06:50:52 INFO - PROCESS | 18859 | 06:50:55 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38984/tests/kraken/driver.html?testName=audio-dft) 06:50:55 INFO - PROCESS | 18859 | RSS: Main: 172417024 06:50:55 INFO - PROCESS | 18859 | 06:50:58 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38984/tests/kraken/driver.html?testName=audio-fft) 06:50:59 INFO - PROCESS | 18859 | RSS: Main: 164421632 06:50:59 INFO - PROCESS | 18859 | 06:51:01 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38984/tests/kraken/driver.html?testName=audio-oscillator) 06:51:02 INFO - PROCESS | 18859 | RSS: Main: 164012032 06:51:02 INFO - PROCESS | 18859 | 06:51:04 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38984/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:51:05 INFO - PROCESS | 18859 | RSS: Main: 164667392 06:51:05 INFO - PROCESS | 18859 | 06:51:08 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38984/tests/kraken/driver.html?testName=imaging-darkroom) 06:51:08 INFO - PROCESS | 18859 | RSS: Main: 164581376 06:51:08 INFO - PROCESS | 18859 | 06:51:12 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38984/tests/kraken/driver.html?testName=imaging-desaturate) 06:51:13 INFO - PROCESS | 18859 | RSS: Main: 163823616 06:51:13 INFO - PROCESS | 18859 | 06:51:15 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38984/tests/kraken/driver.html?testName=json-parse-financial) 06:51:16 INFO - PROCESS | 18859 | RSS: Main: 164716544 06:51:16 INFO - PROCESS | 18859 | 06:51:18 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38984/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:51:18 INFO - PROCESS | 18859 | RSS: Main: 165052416 06:51:18 INFO - PROCESS | 18859 | 06:51:20 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38984/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:51:21 INFO - PROCESS | 18859 | RSS: Main: 164962304 06:51:21 INFO - PROCESS | 18859 | 06:51:23 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38984/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:51:24 INFO - PROCESS | 18859 | RSS: Main: 165527552 06:51:24 INFO - PROCESS | 18859 | 06:51:27 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:51:27 INFO - PROCESS | 18859 | RSS: Main: 166055936 06:51:27 INFO - PROCESS | 18859 | 06:51:30 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:51:31 INFO - PROCESS | 18859 | RSS: Main: 165658624 06:51:31 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | Cycle 1(1): loaded http://localhost:38984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38984/tests/kraken/driver.html?testName=ai-astar) 06:51:33 INFO - PROCESS | 18859 | RSS: Main: 167268352 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | __start_tp_report 06:51:33 INFO - PROCESS | 18859 | _x_x_mozilla_page_load 06:51:33 INFO - PROCESS | 18859 | _x_x_mozilla_page_load_details 06:51:33 INFO - PROCESS | 18859 | |i|pagename|runs| 06:51:33 INFO - PROCESS | 18859 | |0;ai-astar;115;114;115;114;116;126;116;113;112;112 06:51:33 INFO - PROCESS | 18859 | |1;audio-beat-detection;156;134;163;182;139;172;158;133;204;135 06:51:33 INFO - PROCESS | 18859 | |2;audio-dft;161;166;164;172;165;164;161;165;167;163 06:51:33 INFO - PROCESS | 18859 | |3;audio-fft;75;74;73;157;74;74;74;72;150;75 06:51:33 INFO - PROCESS | 18859 | |4;audio-oscillator;93;94;137;93;95;94;150;94;95;148 06:51:33 INFO - PROCESS | 18859 | |5;imaging-gaussian-blur;117;118;118;117;118;118;117;119;119;117 06:51:33 INFO - PROCESS | 18859 | |6;imaging-darkroom;148;148;147;148;148;147;148;147;149;148 06:51:33 INFO - PROCESS | 18859 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;96;96 06:51:33 INFO - PROCESS | 18859 | |8;json-parse-financial;68;67;67;69;67;71;67;98;65;67 06:51:33 INFO - PROCESS | 18859 | |9;json-stringify-tinderbox;64;64;65;65;64;64;63;65;65;64 06:51:33 INFO - PROCESS | 18859 | |10;stanford-crypto-aes;88;79;79;80;85;79;89;84;80;81 06:51:33 INFO - PROCESS | 18859 | |11;stanford-crypto-ccm;140;135;142;136;136;137;137;136;166;136 06:51:33 INFO - PROCESS | 18859 | |12;stanford-crypto-pbkdf2;179;177;173;175;174;174;181;178;178;182 06:51:33 INFO - PROCESS | 18859 | |13;stanford-crypto-sha256-iterative;74;74;81;73;75;72;75;72;76;82 06:51:33 INFO - PROCESS | 18859 | __end_tp_report 06:51:33 INFO - PROCESS | 18859 | __start_cc_report 06:51:33 INFO - PROCESS | 18859 | _x_x_mozilla_cycle_collect,922 06:51:33 INFO - PROCESS | 18859 | __end_cc_report 06:51:33 INFO - PROCESS | 18859 | __startTimestamp1460728293518__endTimestamp 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | ------- Summary: start ------- 06:51:33 INFO - PROCESS | 18859 | Number of tests: 14 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:4.03 (3.5%) stddev-sans-first:4.27 06:51:33 INFO - PROCESS | 18859 | Values: 115.0 114.0 115.0 114.0 116.0 126.0 116.0 113.0 112.0 112.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#1] audio-beat-detection Cycles:10 Average:157.60 Median:160.50 stddev:23.59 (14.7%) stddev-sans-first:25.01 06:51:33 INFO - PROCESS | 18859 | Values: 156.0 134.0 163.0 182.0 139.0 172.0 158.0 133.0 204.0 135.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:3.19 (1.9%) stddev-sans-first:3.07 06:51:33 INFO - PROCESS | 18859 | Values: 161.0 166.0 164.0 172.0 165.0 164.0 161.0 165.0 167.0 163.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#3] audio-fft Cycles:10 Average:89.80 Median:74.00 stddev:33.62 (45.4%) stddev-sans-first:35.24 06:51:33 INFO - PROCESS | 18859 | Values: 75.0 74.0 73.0 157.0 74.0 74.0 74.0 72.0 150.0 75.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:94.00 stddev:24.86 (26.5%) stddev-sans-first:25.66 06:51:33 INFO - PROCESS | 18859 | Values: 93.0 94.0 137.0 93.0 95.0 94.0 150.0 94.0 95.0 148.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 06:51:33 INFO - PROCESS | 18859 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 119.0 117.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:51:33 INFO - PROCESS | 18859 | Values: 148.0 148.0 147.0 148.0 148.0 147.0 148.0 147.0 149.0 148.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:51:33 INFO - PROCESS | 18859 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#8] json-parse-financial Cycles:10 Average:70.60 Median:67.50 stddev:9.75 (14.5%) stddev-sans-first:10.30 06:51:33 INFO - PROCESS | 18859 | Values: 68.0 67.0 67.0 69.0 67.0 71.0 67.0 98.0 65.0 67.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 06:51:33 INFO - PROCESS | 18859 | Values: 64.0 64.0 65.0 65.0 64.0 64.0 63.0 65.0 65.0 64.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:3.84 (4.6%) stddev-sans-first:3.49 06:51:33 INFO - PROCESS | 18859 | Values: 88.0 79.0 79.0 80.0 85.0 79.0 89.0 84.0 80.0 81.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:137.00 stddev:9.35 (6.8%) stddev-sans-first:9.92 06:51:33 INFO - PROCESS | 18859 | Values: 140.0 135.0 142.0 136.0 136.0 137.0 137.0 136.0 166.0 136.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:178.00 stddev:3.07 (1.7%) stddev-sans-first:3.18 06:51:33 INFO - PROCESS | 18859 | Values: 179.0 177.0 173.0 175.0 174.0 174.0 181.0 178.0 178.0 182.0 06:51:33 INFO - PROCESS | 18859 | 06:51:33 INFO - PROCESS | 18859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:75.00 stddev:3.47 (4.6%) stddev-sans-first:3.64 06:51:33 INFO - PROCESS | 18859 | Values: 74.0 74.0 81.0 73.0 75.0 72.0 75.0 72.0 76.0 82.0 06:51:33 INFO - PROCESS | 18859 | -------- Summary: end -------- 06:51:33 INFO - PROCESS | 18859 | 06:51:34 INFO - TEST-INFO | 18859: exit 0 06:51:34 INFO - TEST-OK | kraken | took 63839ms 06:51:34 INFO - SUITE-END | took 1178s 06:51:34 INFO - Completed test suite (00:19:38) 06:51:34 INFO - javascript benchmark 06:51:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.7816535594475, 2645.3122188231055, 2684.194741577526, 2688.5698288273866, 2699.0, 4668.649851261152, 4688.460827004891, 4688.882777930554, 4709.835155769549, 4743.193657078296, 4581.79381927814, 4597.195490789107, 4690.671652984292, 4751.738654374008, 4795.448523419807, 4366.345048242765, 4460.3309503574565, 4463.174312752135, 4465.776711164445, 4471.396361491205, 413.3295583420111, 4313.913721725564, 4339.88167550643, 4379.5182529921685, 4432.933505997413, 4375.168717943612, 4378.584034516716, 4386.605205531486, 4387.9561204387865, 4413.16149931512, 4130.690198235145, 4470.396496472967, 4479.440069991251, 4490.326451032339, 4520.864374068783, 4252.149570085995, 4297.35539669049, 4320.222359975203, 4339.652827773771, 4354.172707185625, 4601.493835678073, 4619.353290539327, 4642.048380082108, 4671.159191345557, 4702.3416721659, 5049.722265275408, 5053.36832895888, 5092.10888094582, 5094.439611642716, 5114.820981265638, 5103.770330335144, 5104.872378190538, 5105.5149760772665, 5109.41241757199, 5110.054639891595, 4725.740084295397, 4738.289256611536, 4743.359646447754, 4748.074125545486, 4751.881202969884, 4976.0794253063295, 5114.002769459919, 5183.3261675981885, 5189.351331083614, 5230.267762513251, 4962.181240095344, 4963.156263435225, 4963.45402005779, 4977.850664480072, 5002.74986250686, 4992.151334273182, 5006.3992320921, 5008.023435430056, 5026.346574945233, 5093.879346543755, 4846.248831431134, 5010.073136469765, 5064.822731204464, 5072.4673909239, 5073.797048118107, 4673.299005149255, 5020.49795020495, 5050.065737838511, 5069.0, 5102.158143906214, 4270.295401258758, 4323.913521729548, 4324.502682191525, 4328.931058686491, 4369.781510924441, 3574.749767516249, 3665.1020499977144, 3698.093966978108, 3746.925061498809, 3780.7920564368674, 4413.7572433515825, 4415.2935530315, 4415.823367065345, 4449.0, 4455.955440445554, 4871.80512779492, 5131.1277082895995, 5144.588432925357, 5159.922601160985, 5162.328897243335, 4379.58393952574, 4421.624161946271, 4427.690061695715, 4445.1998640245065, 4464.732116073046, 4494.191045611821, 4511.481179664315, 4522.525134860858, 4523.140603285366, 4556.7721613919175, 4560.498345181961, 4744.620430365631, 4781.139394908881, 4793.736344501016, 4808.759562021885, 4924.236743304794, 4965.404151501699, 4985.0, 4996.675216111086, 5004.574611158092, 4616.561426664462, 4668.015248584756, 4685.273782563708, 4697.577218050392, 4706.882327941828, 4814.975925120352, 4878.048780487771, 4930.038642464685, 4974.303597496426, 5033.672811267256, 5084.949150508448, 5111.05445492585, 5113.821016264413, 5117.2068329409, 5134.255532947627, 4968.850934471827, 4981.42713587942, 4983.900321993612, 4992.425871024879, 4995.400551933792, 4720.386349774507, 4910.631702622246, 4942.925856112233, 4976.5023497649945, 5029.974850125726, 4603.746793926366, 4765.070811191785, 4849.781759820887, 4860.441049279378, 4936.136176169084, 4972.453030166606, 4980.526849949249, 4999.850004499871, 5009.724465154306, 5073.985202959497, 4662.580367766917, 4825.927611085766, 4892.290617860462, 4893.510648935078, 4918.704877707349], "value": 4612.768315086585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.5474102829277, 612.4855121697773, 617.435046932057, 637.1016866218632, 641.3938827807724, 32432.513512297304, 33330.1667458313, 33332.83333583332, 33387.49918751221, 33530.832345838266, 36593.26813463729, 37536.62463375366, 37541.249175016485, 37647.623523764756, 37700.62299377012, 7724.536527808335, 7904.762857114267, 7914.050313962332, 7919.287264146225, 7925.524468531907, 7760.262775036363, 7884.172161923001, 7885.172056934025, 7889.250521200477, 7899.0, 7845.764627061198, 7872.448928575002, 7929.9207007930045, 7947.165547617504, 7952.681892724284, 7862.52824830512, 7881.881771773428, 7892.80267993299, 7925.3263472604895, 7941.761747147595, 7722.382209423233, 7737.806554836118, 7850.528968261866, 7866.449348545604, 7869.724559640443, 31833.681663183303, 33891.32217355664, 34475.13812154716, 34484.65515344865, 34630.13424664403, 3056.847157642131, 3147.3705258948303, 3340.9832950835334, 3620.4388319810473, 3787.3182827091387, 27050.188494345202, 27382.315442113908, 27437.86281068602, 28314.150575482767, 28433.28916777097, 3363.899083027489, 3364.730821534296, 3365.713914317286, 3402.914927126817, 3429.2455659754814, 187885.0, 193186.0, 193692.0, 194372.0, 194499.02750486298, 33738.66261337404, 35013.47479787805, 56300.71849640726, 57800.0, 57800.132998005065, 34112.65887341144, 34220.0, 34375.140621484665, 34482.48276275858, 34494.137646558534, 13103.2138071716, 13141.802872956914, 13244.801327980089, 13291.468341266434, 13337.333133343294, 10791.190660700478, 10857.185711071701, 10941.945290273497, 10967.287126336763, 11004.779904402027, 8425.4944703318, 8442.409031367868, 8462.323014158976, 8488.193621605938, 8562.272206862363, 3287.769856110049, 3303.9504407433906, 3362.4115779738936, 3363.630000699921, 3378.138574663494, 912.2838571721167, 917.3074328881652, 974.8635191073255, 989.678354534779, 994.3188915592842, 27829.721702783118, 27896.581551276748, 28446.573301400495, 28848.567271490945, 28931.42137157245, 985.6599473181741, 1012.1902478017556, 1021.6168936648756, 1053.8735351757684, 1061.9893801062044, 14862.256887155816, 15226.233220601565, 15420.383184672712, 15527.146006969726, 15712.764308535381, 355000.0, 355698.0, 359071.81856362725, 359517.0, 360859.0, 48307.75846120747, 49347.50652493429, 49517.0, 49678.0, 49874.501254986986, 1205.9577914773117, 1222.3338280637074, 1262.678017105632, 1262.8673989231, 1272.2748033620746, 24719.752802471747, 25714.35714107162, 26459.867700661373, 26520.0, 26523.204303870916, 43396.13207735891, 43429.78285108554, 43575.78212108919, 43785.56214437942, 43794.56205437905, 325391.0, 327124.0, 327127.0, 327768.0, 328722.0, 25541.616875746506, 25763.742362576882, 26269.868650656623, 26335.20994370172, 26385.208443746717, 41510.0, 41663.58336416597, 42139.15721685488, 42334.36498452587, 42806.0, 36065.63934360623, 36158.638413615525, 36346.636533635385, 36857.07857303589, 37128.81435592805, 36221.27557448889, 36468.81765591155, 36489.27021459503, 36841.0, 37257.0, 31608.683913161494, 35713.0, 36377.27245455129, 36388.27223455569, 37165.81417092897, 28532.85733571319, 31912.458946555565, 32157.35685286328, 32291.51562726608, 32419.35161296808, 24785.1325203617, 24811.25566233016, 24895.0, 24910.875445622656, 25031.0], "value": 16329.678725131811, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.608850927799, 382.5022602406288, 384.8210582079333, 387.4614286142263, 392.42509723255426, 15756.290966906488, 16980.0, 17141.228644711002, 17622.207000684968, 17765.378211762607, 15361.30874110665, 15794.84205157948, 16164.676706465863, 16230.188490575454, 16266.593335166626, 4988.725620090893, 5152.407473140581, 5184.844454666347, 5189.455107213726, 5197.714125723083, 3621.674049335559, 5568.916466253009, 5904.911426328608, 5906.911396329058, 5909.586328956974, 5625.099984002561, 5834.183214349994, 5848.795292164775, 5849.181114643953, 5878.588498805086, 5824.534037277008, 5838.824835254949, 5863.208466856962, 5885.146653735227, 5890.263717035371, 4537.546245375469, 4890.951090489085, 5164.2253661950635, 5175.327207463006, 5185.0, 12571.685707857285, 12601.180923240052, 17265.741013884803, 19069.809301906942, 19441.902790485958, 1810.0, 1845.5017145370675, 1908.475169328432, 2022.6055919095782, 2220.433789383697, 8663.870041949376, 8780.736577902673, 9291.58187881547, 9404.388714733588, 9412.058794120534, 1677.966440671192, 1776.600264940391, 1847.667419864424, 1876.1088482970615, 1881.4637828218893, 63824.0, 64882.35117648858, 65563.34436655621, 65811.341886581, 66217.00674489935, 9480.620775169054, 9707.563159657833, 10169.898301017043, 10836.133109351233, 10919.617813376493, 14032.08791428554, 14075.859241407456, 14155.29223538819, 14191.148531088167, 14208.147511149364, 6901.482388820858, 7156.355927966404, 7226.168990566047, 7387.7783666490095, 7462.08978498386, 6765.830854228585, 6798.5241033128195, 6896.172459304916, 6922.203946546111, 6983.8603227935155, 4350.151720414552, 4389.846355377546, 4433.7118087324225, 4464.352668862996, 4542.091581683677, 1739.5738044179257, 1807.466797294775, 1921.423572928116, 1925.1433112265188, 1953.4530331506917, 832.3632421197789, 878.2052242720348, 913.0413066280379, 953.580424613168, 976.5068640336584, 15783.842161578466, 16378.181090945405, 16585.50243492697, 16650.417235396944, 16841.242144103544, 829.8547754143121, 851.8722191671175, 874.7332063720627, 900.0, 970.0445061614304, 9129.315301352424, 9135.634574617074, 9151.771205719777, 9474.147326740627, 9552.856707149398, 381602.0, 395132.3894088466, 399785.0, 410462.0, 411707.0, 79352.60323698344, 82027.0, 82115.58942205251, 82175.5891220552, 82677.58661206656, 938.4697645830221, 945.7541039329824, 960.3373672166183, 980.0493521284343, 980.2305190425624, 14547.636309092357, 14710.779338310149, 14721.705565888837, 14736.0, 14787.778183327044, 31752.841235793672, 32419.082282594678, 33251.33497329991, 34284.65715342815, 34520.30959380849, 44783.77608111939, 44818.0, 45523.08953820839, 45535.31697024614, 45548.0, 7400.629968501661, 7497.737579184921, 7526.720457522344, 7599.936008958861, 7650.693972241048, 10281.897181028095, 11367.374794386387, 11619.244749091282, 11676.124290678403, 11676.824847627462, 9596.808063838824, 9656.970553404963, 9754.707358779247, 9813.803723925339, 9965.950170249102, 9849.852252216078, 9992.15066719337, 10035.849462257926, 10220.233482488695, 10289.639862604772, 9435.961730771958, 9659.32384733062, 9742.561584728846, 10309.432981186106, 10530.736731581464, 7625.466217364731, 7724.884126738216, 7728.574928378768, 7782.44351129765, 7864.056313242448, 9277.86083208766, 9837.60649574009, 9902.752431189278, 9926.15627671656, 10202.132818710195], "value": 8117.426931218376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.0228244793539, 1468.8898332625051, 1601.8077830660322, 1708.957276068099, 1771.0613374911302, 6830.077939478169, 7714.6914123435, 7887.763367098996, 7983.600819959001, 8001.279884810366, 7910.762677119696, 7919.881201781978, 7921.445498815086, 7995.360371170307, 8015.879761803578, 2225.121077174515, 2237.407087121906, 2254.0870947266385, 2257.1535674122206, 2265.0713207584813, 2189.1681161158735, 2210.668399740036, 2257.5146343536135, 2257.582347265753, 2263.026898433673, 2225.7551669316445, 2259.1302348595746, 2264.9660255096187, 2281.7147856517936, 2304.28567144185, 2216.6674998750154, 2216.8780717060554, 2220.7002054722648, 2224.3215819175143, 2228.799408053283, 2179.193698331612, 2197.2968650031994, 2216.966745498819, 2218.0351547077075, 2219.889005549716, 8058.073321568036, 8058.315043221333, 8125.674973001072, 8126.959365203136, 8142.837143257161, 4515.571020753023, 4681.438227412732, 4683.391159149289, 4705.082508910764, 4709.740964246965, 2793.511135551291, 2938.9118326450025, 2939.088882446427, 2942.970570294291, 2977.8511074446405, 950.2872845365976, 955.2310390135938, 959.640134949394, 977.3207620703614, 996.6063404955003, 10779.78440431187, 10888.0, 10892.455377231028, 10900.07349375304, 10904.781904361947, 4152.148809494047, 4236.195122926696, 4304.612584867315, 4371.060222052274, 4404.273294906368, 9298.581563829644, 9310.953445232866, 9317.301202409846, 9318.207952324128, 9336.11306925841, 4697.647676424282, 4711.45818230901, 4722.433308003062, 4726.26742854858, 4733.739644319596, 3759.812009399519, 4128.690348223895, 4210.0, 4279.165562715303, 4305.375720520569, 3746.8126593670754, 3799.5820459749407, 3824.29250588642, 3875.748076375027, 3886.6696330812197, 1215.4469716279248, 1222.0895432902366, 1224.8591411987557, 1237.9257244565356, 1238.795598726218, 760.9923900760922, 865.446114486729, 869.6347534035593, 874.07784787049, 890.4657205676672, 5312.628116031918, 5423.186522021729, 5465.9180112298345, 5496.780128794803, 5569.415211402826, 423.2445085522389, 425.9403683484315, 428.18858263590323, 923.4413180026122, 935.6631612619451, 3531.8763843265874, 3633.527641406653, 3689.5572531296416, 3696.2607478504406, 3722.9813850930573, 9924.354916930377, 10181.694549163536, 10246.180305575535, 10352.896471035343, 10383.013613706686, 9959.850602240973, 10121.645742398981, 10128.848067278997, 10140.391576505433, 10177.33847299938, 7023.403010744144, 7058.752943646948, 7215.314545118205, 7235.89146162808, 7237.203907570163, 5253.553447956967, 5277.0, 5303.814366497154, 5340.679559226459, 5345.1714984177515, 9070.727878163665, 9332.860007099764, 9364.250859931053, 9421.104995025462, 9435.575399107194, 9159.954200229222, 9291.907080929375, 9496.715098547054, 9543.236541076836, 9573.18627916635, 5812.418758124154, 6386.361363863576, 6427.55007149495, 6477.481801455967, 6599.505037122139, 7789.766307010798, 7797.532148071134, 7810.765677029698, 7835.608219589112, 7836.412269079956, 6917.619530925847, 7144.1784194818265, 7156.928430715626, 7182.138143422822, 7225.5664660120565, 7008.7546935857, 7015.579065256101, 7035.753748618774, 7131.8573628528175, 7146.964265178641, 6127.479164271087, 6347.619142851444, 6353.047042943595, 6374.107624932421, 6568.408843204134, 4442.267025940683, 4548.295014272793, 4556.567126123013, 4596.5863072323655, 4628.768561571976, 4576.519465456079, 4653.557911998355, 4680.625549956064, 4694.671373003857, 4729.148753224453], "value": 4205.695302029413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.3409374407488, 320.9374172036452, 324.8002478475738, 326.36521964778507, 328.3580599927143, 4820.301056346828, 5351.759170837312, 5378.633401303424, 5433.18502224666, 5433.701146436944, 5360.678359298445, 5362.410134885169, 5365.248865158881, 5365.490278423554, 5399.0, 4185.497740271172, 4198.160367926412, 4202.348635961431, 4203.537610862811, 4203.621674049335, 3904.0, 4215.536291008002, 4218.493780746315, 4220.0, 4232.195882782277, 4075.0, 4093.6520395766397, 4094.303968325377, 4094.815733291994, 4098.8565400211, 4083.7958102094926, 4107.732997355177, 4121.979390103061, 4125.855595054189, 4137.627613514768, 3451.913702157441, 3586.5696116466193, 3588.5693716753894, 3599.3881040223223, 3599.6681227945564, 5137.998090372379, 5154.381474223117, 5166.560842328407, 5170.784865556591, 5177.326947496801, 4670.929936050962, 4673.055974735895, 4710.434747830248, 4736.218523943545, 4764.0, 5480.534154596864, 5585.022621041301, 5588.580856435784, 5614.63504872182, 5637.802676906289, 3823.7896915669626, 3860.3823388257742, 3866.8066596670337, 3872.5933776953298, 3872.7676339419727, 5588.385277619459, 5722.227499287585, 5886.764529418818, 5904.675242861641, 5934.6142500737315, 4005.959940400617, 4008.4588580541254, 4011.4584531088512, 4015.2170326785995, 4023.456833327522, 4018.778967156776, 4071.185762847442, 4088.1619268049976, 4093.2427500912427, 4102.138550904344, 4573.405457290531, 4642.2340313847835, 4668.089722504147, 4681.133990211822, 4684.461286951976, 5618.061768689796, 5624.128260119688, 5633.0987042073075, 5633.549316054706, 5635.690037048002, 1390.1520072755611, 1417.588899219215, 1424.2807382271887, 1424.6936908564708, 1431.9642008949859, 916.6287653500343, 932.3007744191856, 949.2453499467939, 959.8608201810838, 965.4834663455018, 4910.361652985089, 4921.26181072842, 4933.161362568372, 4940.777665005012, 4946.727929963887, 5760.452756988079, 5806.912896306559, 5817.214676018683, 5819.767209311664, 5835.854103647443, 4821.325014497973, 4911.656184067152, 4940.382452193476, 4942.975285123552, 4959.20652695567, 3127.9061628151194, 3134.138112019213, 3139.968600314013, 3142.2929840786096, 3149.1969547765175, 5421.430749771217, 5434.782608695687, 5474.616776825664, 5495.313085864267, 5509.512431643434, 5760.3951585083805, 5905.202797622352, 5953.8742160366155, 5957.582969192115, 5975.342712301644, 5401.0, 5404.054290499225, 5437.564994800407, 5445.618806683573, 5500.917486237629, 5611.691356975405, 5774.133879918046, 5801.6519008859605, 5822.184894114743, 5828.329742079715, 5687.630304030225, 5698.202251684685, 5704.573856535866, 5710.086386178192, 5723.65658060501, 5208.348956380452, 5301.6818990860675, 5403.594730395157, 5452.09176788121, 5504.990678402434, 3940.2907476654477, 3947.309220886276, 3956.208758248304, 3970.1861118470065, 3977.0455090778582, 5806.332271788799, 5847.795327163529, 5856.297244330707, 5902.852428689317, 5905.734241959208, 5464.726763661881, 5634.52106570946, 5651.858703532444, 5672.12082127271, 5672.517835983987, 5630.4369563043365, 5660.32076150848, 5663.773449061991, 5672.376038635829, 5683.403242659627, 5399.217113518596, 5556.527695145796, 5572.721363931868, 5587.8882422352135, 5591.0, 5659.717014149359, 5662.971685141712, 5718.142278658234, 5719.8570035749435, 5720.599558031065, 5577.219189313419, 5582.972085139549, 5593.216949626974, 5606.103023516218, 5607.186957891001], "value": 4211.099712797181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.9022841687959, 681.8534015186734, 681.9556728812628, 701.9996504980402, 736.8305289783351, 11628.883711162896, 12232.938835305822, 12467.688307792298, 12499.875001249984, 13785.931070344659, 13622.931885340584, 13656.453741850339, 13664.590062298123, 13687.384067716952, 13742.58772236832, 654.4371840217409, 831.085805613823, 832.7418500264907, 832.862577674686, 837.2464781696461, 800.7837883771407, 828.1635548096406, 828.7099515169673, 829.1418381974657, 829.531314807135, 855.8159995600945, 858.9226969572737, 866.0906048648925, 869.3914260017981, 869.6651789061225, 855.9572021398906, 856.8500512410303, 858.6651206029653, 862.1421685422981, 863.896332440105, 619.5724949784634, 621.561798931752, 628.0516420205477, 629.0187307799847, 629.710333246707, 12661.30362830044, 12705.682357941034, 12733.108682392236, 12735.74528509434, 12790.808137877939, 12298.569550065704, 12368.0, 12411.875881241253, 12553.686157846036, 12784.6803829905, 10246.436445995467, 10280.845787313121, 10341.586336546605, 10578.894211057868, 10643.361398316049, 3256.495243237302, 3334.3498017886523, 3355.1947532592244, 3363.024722830376, 3367.96632033679, 45505.0, 45796.3130553042, 46538.767306163594, 46582.301265481045, 47009.294860577116, 9579.568919398644, 9705.951470242604, 9815.705528834147, 10046.447445390573, 10136.949315253376, 16722.581935451468, 17002.319907203822, 17002.829971700125, 17109.914450427666, 17133.91433042827, 6779.525433219627, 6867.828304292432, 6872.69072891721, 7001.194862590867, 7065.187503437068, 3961.58403367648, 4024.8188831502653, 4029.778362190049, 4036.616521430459, 4071.6539094176733, 2838.815476993989, 2933.1640482462394, 2935.515639919432, 2940.5736168255485, 2958.423107494018, 531.6650510178563, 535.9598030147677, 539.3393093460479, 543.0713479949252, 547.1327945206813, 551.1154596872043, 577.8353169346716, 584.4593750780512, 622.9127922090911, 641.6246495800009, 7682.347000504908, 8248.670053197924, 8307.501549907025, 8382.706605268786, 8431.831363372698, 576.3602699635659, 600.1447936690199, 623.8658688381929, 628.3214128740949, 629.222909706512, 3444.534987776668, 3511.877084302037, 3575.4458059000895, 3645.453182022665, 3687.7049836013052, 42813.571864281585, 53502.0, 54080.188797167284, 54280.45719542833, 54494.45505544894, 43924.341134883005, 43966.99999999936, 44774.552254477036, 44843.0, 45384.54615453869, 38770.224595507934, 39703.40444893329, 40204.0, 40446.0, 40514.39228411576, 7666.923330766621, 7966.920330796618, 8118.3099436548555, 8156.102828688958, 8375.32997360222, 27385.58921616217, 27489.0, 27783.44433111286, 27859.582106268015, 28169.859150704116, 36940.81529592335, 38032.80983595064, 38140.0, 38192.23615527729, 38282.42576361301, 10556.683299501028, 10560.904707530704, 10631.681049568217, 10914.563417463212, 10997.835032474679, 11885.147564584611, 11908.821367679666, 11969.222000569935, 11991.129415491649, 12056.698582535506, 10981.725456863642, 11165.49755260999, 11180.161487888277, 11568.595099171489, 11572.768544628892, 11116.61091861781, 11171.739098113161, 11333.320000799979, 11588.188826782045, 11735.589254376397, 11162.162837787037, 11291.3789741565, 11350.318980861175, 11424.657260282205, 11531.538738450368, 9485.66800161991, 9515.429074255568, 9609.375390599589, 9658.130768230892, 9805.656802011896, 9295.76760580991, 9521.857172142561, 9621.615135394786, 9802.117809397188, 9859.211263098792], "value": 5994.489449702952, "unit": "score"}], "name": "dromaeo_css", "value": 6339.634330183249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 116.0, 126.0, 116.0, 113.0, 112.0, 112.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 163.0, 182.0, 139.0, 172.0, 158.0, 133.0, 204.0, 135.0], "value": 157.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 164.0, 172.0, 165.0, 164.0, 161.0, 165.0, 167.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 157.0, 74.0, 74.0, 74.0, 72.0, 150.0, 75.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 137.0, 93.0, 95.0, 94.0, 150.0, 94.0, 95.0, 148.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 119.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 149.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 69.0, 67.0, 71.0, 67.0, 98.0, 65.0, 67.0], "value": 70.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 63.0, 65.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 79.0, 80.0, 85.0, 79.0, 89.0, 84.0, 80.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 142.0, 136.0, 136.0, 137.0, 137.0, 136.0, 166.0, 136.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 173.0, 175.0, 174.0, 174.0, 181.0, 178.0, 178.0, 182.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 81.0, 73.0, 75.0, 72.0, 75.0, 72.0, 76.0, 82.0], "value": 75.4, "unit": "score"}], "name": "kraken", "value": 1607.5999999999997, "alertThreshold": 2.0}]} 06:51:34 INFO - Return code: 0 06:51:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:51:34 ERROR - # TBPL SUCCESS # 06:51:34 INFO - Running post-action listener: _resource_record_post_action 06:51:34 INFO - Running post-run listener: _resource_record_post_run 06:51:35 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 517677056; Read time: 348; Write time: 514628 06:51:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 233586688; Read time: 240; Write time: 305424 06:51:35 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284090368; Read time: 108; Write time: 209204 06:51:35 INFO - Running post-run listener: _upload_blobber_files 06:51:35 INFO - Blob upload gear active. 06:51:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:51:35 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 06:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:51:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:37 INFO - (blobuploader) - INFO - Done attempting. 06:51:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:51:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:37 INFO - (blobuploader) - INFO - Done attempting. 06:51:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:51:37 INFO - Return code: 0 06:51:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:51:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:51:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca1558cb1f3de3babac00caad68f100f0eef3d4825a448124562096b8db8c880f77fc356921b357f9ac280f9594abed4a503f8033d966da263c375ce0b22837b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28b35de3be3a1f9a8381a178b50a9e0dc1b3dab6eab80888991246815d87d9cc9975c89a71a85b9decbbce64f47850ba89e3c21f2311fb5cf13b4e8554d76bf2"} 06:51:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:51:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:51:37 INFO - Contents: 06:51:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca1558cb1f3de3babac00caad68f100f0eef3d4825a448124562096b8db8c880f77fc356921b357f9ac280f9594abed4a503f8033d966da263c375ce0b22837b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28b35de3be3a1f9a8381a178b50a9e0dc1b3dab6eab80888991246815d87d9cc9975c89a71a85b9decbbce64f47850ba89e3c21f2311fb5cf13b4e8554d76bf2"} 06:51:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:51:37 INFO - Copying logs to upload dir... 06:51:37 INFO - mkdir: /builds/slave/test/build/upload/logs 06:51:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.879195 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-15 06:51:37.660241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 06:51:37.663974) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca1558cb1f3de3babac00caad68f100f0eef3d4825a448124562096b8db8c880f77fc356921b357f9ac280f9594abed4a503f8033d966da263c375ce0b22837b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28b35de3be3a1f9a8381a178b50a9e0dc1b3dab6eab80888991246815d87d9cc9975c89a71a85b9decbbce64f47850ba89e3c21f2311fb5cf13b4e8554d76bf2"} build_url:https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/cTivLJuVQIiqujyG9uxAJw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ca1558cb1f3de3babac00caad68f100f0eef3d4825a448124562096b8db8c880f77fc356921b357f9ac280f9594abed4a503f8033d966da263c375ce0b22837b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28b35de3be3a1f9a8381a178b50a9e0dc1b3dab6eab80888991246815d87d9cc9975c89a71a85b9decbbce64f47850ba89e3c21f2311fb5cf13b4e8554d76bf2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 06:51:37.691313) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:51:37.692048) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460727063.89025-1751071413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:51:37.776254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 06:51:37.776832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 06:51:37.777171) ========= ========= Total master_lag: 0.19 =========