builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1461616476.9 results: success (0) buildid: 20160425103006 builduid: 1a87fa8d522747ab8b0da4138352f4b4 revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:36.903571) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:36.904008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:36.904314) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:36.920454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:36.920725) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 13:34:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-04-25 13:34:37 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.263335 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:37.197554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:37.197879) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018860 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:37.247461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:34:37.247814) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --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=2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 13:34:37,618 truncating revision to first 12 chars 2016-04-25 13:34:37,618 Setting DEBUG logging. 2016-04-25 13:34:37,618 attempt 1/10 2016-04-25 13:34:37,618 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d6a91c76a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 13:34:38,933 unpacking tar archive at: mozilla-aurora-0d6a91c76a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:34:38.860847) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:38.861304) ========= script_repo_revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:38.861717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:38.861993) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:34:38.870213) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-25 13:34:38.870505) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:34:39 INFO - MultiFileLogger online at 20160425 13:34:39 in /builds/slave/test 13:34:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:34:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:34:39 INFO - {'append_to_log': False, 13:34:39 INFO - 'base_work_dir': '/builds/slave/test', 13:34:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:34:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:34:39 INFO - 'branch': 'Mozilla-Aurora', 13:34:39 INFO - 'buildbot_json_path': 'buildprops.json', 13:34:39 INFO - 'config_files': ('talos/linux_config.py',), 13:34:39 INFO - 'default_actions': ('clobber', 13:34:39 INFO - 'read-buildbot-config', 13:34:39 INFO - 'download-and-extract', 13:34:39 INFO - 'populate-webroot', 13:34:39 INFO - 'create-virtualenv', 13:34:39 INFO - 'install', 13:34:39 INFO - 'run-tests'), 13:34:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:34:39 INFO - 'download_minidump_stackwalk': True, 13:34:39 INFO - 'download_symbols': 'ondemand', 13:34:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:34:39 INFO - 'tooltool.py': '/tools/tooltool.py', 13:34:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:34:39 INFO - '/tools/misc-python/virtualenv.py')}, 13:34:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:34:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:34:39 INFO - 'installer_path': 'installer.exe', 13:34:39 INFO - 'log_level': 'info', 13:34:39 INFO - 'log_name': 'talos', 13:34:39 INFO - 'log_to_console': True, 13:34:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:34:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:34:39 INFO - 'opt_config_files': (), 13:34:39 INFO - 'pip_index': False, 13:34:39 INFO - 'sps_profile': False, 13:34:39 INFO - 'sps_profile_interval': 0, 13:34:39 INFO - 'suite': 'dromaeojs-e10s', 13:34:39 INFO - 'system_bits': '32', 13:34:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:34:39 INFO - 'title': 'talos-linux64-ix-012', 13:34:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:34:39 INFO - 'use_talos_json': True, 13:34:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:34:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:34:39 INFO - 'work_dir': 'build'} 13:34:39 INFO - ##### 13:34:39 INFO - ##### Running clobber step. 13:34:39 INFO - ##### 13:34:39 INFO - Running pre-action listener: _resource_record_pre_action 13:34:39 INFO - Running main action method: clobber 13:34:39 INFO - rmtree: /builds/slave/test/build 13:34:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:34:40 INFO - Running post-action listener: _resource_record_post_action 13:34:40 INFO - ##### 13:34:40 INFO - ##### Running read-buildbot-config step. 13:34:40 INFO - ##### 13:34:40 INFO - Running pre-action listener: _resource_record_pre_action 13:34:40 INFO - Running main action method: read_buildbot_config 13:34:40 INFO - Using buildbot properties: 13:34:40 INFO - { 13:34:40 INFO - "project": "", 13:34:40 INFO - "product": "firefox", 13:34:40 INFO - "script_repo_revision": "production", 13:34:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:34:40 INFO - "repository": "", 13:34:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:34:40 INFO - "buildid": "20160425103006", 13:34:40 INFO - "pgo_build": "True", 13:34:40 INFO - "basedir": "/builds/slave/test", 13:34:40 INFO - "buildnumber": 318, 13:34:40 INFO - "slavename": "talos-linux64-ix-012", 13:34:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:34:40 INFO - "platform": "ubuntu64_hw", 13:34:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:34:40 INFO - "branch": "mozilla-aurora", 13:34:40 INFO - "repo_path": "releases/mozilla-aurora", 13:34:40 INFO - "revision": "0d6a91c76a9eddf2219caf028dea130f2d683ec2", 13:34:40 INFO - "stage_platform": "linux64-pgo", 13:34:40 INFO - "builduid": "1a87fa8d522747ab8b0da4138352f4b4", 13:34:40 INFO - "slavebuilddir": "test" 13:34:40 INFO - } 13:34:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:34:40 INFO - Running post-action listener: _resource_record_post_action 13:34:40 INFO - ##### 13:34:40 INFO - ##### Running download-and-extract step. 13:34:40 INFO - ##### 13:34:40 INFO - Running pre-action listener: _resource_record_pre_action 13:34:40 INFO - Running main action method: download_and_extract 13:34:40 INFO - mkdir: /builds/slave/test/build/tests 13:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:40 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:34:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:34:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:34:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:34:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:34:41 INFO - Downloaded 1361 bytes. 13:34:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:34:41 INFO - Using the following test package requirements: 13:34:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:34:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:34:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:34:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:34:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:34:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:34:41 INFO - u'jsshell-linux-x86_64.zip'], 13:34:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:34:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:34:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:34:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:34:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:34:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:34:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:34:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:34:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:34:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:34:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:34:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:34:41 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')]} 13:34:41 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:34:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:34:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:34:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:34:42 INFO - Downloaded 23819986 bytes. 13:34:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:34:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:34:43 INFO - Return code: 0 13:34:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:43 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:34:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:34:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:34:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:34:45 INFO - Downloaded 23819986 bytes. 13:34:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:34:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:34:46 INFO - Return code: 0 13:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:46 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:34:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:34:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:34:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:34:47 INFO - Downloaded 10840145 bytes. 13:34:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:34:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:34:47 INFO - Return code: 0 13:34:47 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')]} 13:34:47 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:34:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:34:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:34:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:34:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:34:49 INFO - Downloaded 62670906 bytes. 13:34:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:34:49 INFO - mkdir: /builds/slave/test/properties 13:34:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:34:49 INFO - Writing to file /builds/slave/test/properties/build_url 13:34:49 INFO - Contents: 13:34:49 INFO - build_url:https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:34:50 INFO - Running post-action listener: _resource_record_post_action 13:34:50 INFO - Running post-action listener: set_extra_try_arguments 13:34:50 INFO - ##### 13:34:50 INFO - ##### Running populate-webroot step. 13:34:50 INFO - ##### 13:34:50 INFO - Running pre-action listener: _resource_record_pre_action 13:34:50 INFO - Running main action method: populate_webroot 13:34:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:34:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:34:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:34:50 INFO - '--tppagecycles', 13:34:50 INFO - '7'], 13:34:50 INFO - 'tests': ['tsvgm']}}, 13:34:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:34:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:34:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:34:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:34:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:50 INFO - 'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:34:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:34:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:50 INFO - 'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['damp', 'tps']}, 13:34:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:50 INFO - 'tests': ['damp', 'tps']}, 13:34:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['dromaeo_dom']}, 13:34:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:34:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['a11yr', 13:34:50 INFO - 'ts_paint', 13:34:50 INFO - 'tpaint', 13:34:50 INFO - 'sessionrestore', 13:34:50 INFO - 'sessionrestore_no_auto_restore', 13:34:50 INFO - 'tabpaint']}, 13:34:50 INFO - 'other-e10s': {'tests': ['a11yr', 13:34:50 INFO - 'ts_paint', 13:34:50 INFO - 'tpaint', 13:34:50 INFO - 'sessionrestore', 13:34:50 INFO - 'sessionrestore_no_auto_restore', 13:34:50 INFO - 'tabpaint']}, 13:34:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:34:50 INFO - 'ts_paint', 13:34:50 INFO - 'tpaint', 13:34:50 INFO - 'sessionrestore', 13:34:50 INFO - 'sessionrestore_no_auto_restore', 13:34:50 INFO - 'tabpaint']}, 13:34:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:34:50 INFO - 'ts_paint', 13:34:50 INFO - 'tpaint', 13:34:50 INFO - 'sessionrestore', 13:34:50 INFO - 'sessionrestore_no_auto_restore', 13:34:50 INFO - 'tabpaint']}, 13:34:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['a11yr', 13:34:50 INFO - 'ts_paint', 13:34:50 INFO - 'tpaint', 13:34:50 INFO - 'sessionrestore', 13:34:50 INFO - 'sessionrestore_no_auto_restore', 13:34:50 INFO - 'tabpaint']}, 13:34:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['a11yr', 13:34:50 INFO - 'ts_paint', 13:34:50 INFO - 'tpaint', 13:34:50 INFO - 'sessionrestore', 13:34:50 INFO - 'sessionrestore_no_auto_restore', 13:34:50 INFO - 'tabpaint']}, 13:34:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['tsvgx', 13:34:50 INFO - 'tsvgr_opacity', 13:34:50 INFO - 'tart', 13:34:50 INFO - 'tscrollx', 13:34:50 INFO - 'cart']}, 13:34:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:34:50 INFO - 'tsvgr_opacity', 13:34:50 INFO - 'tart', 13:34:50 INFO - 'tscrollx', 13:34:50 INFO - 'cart']}, 13:34:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:50 INFO - 'talos_options': ['--disable-e10s'], 13:34:50 INFO - 'tests': ['tp5o']}, 13:34:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:50 INFO - 'tests': ['tp5o']}, 13:34:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:50 INFO - 'talos_options': ['--disable-e10s', 13:34:50 INFO - '--xperf_path', 13:34:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:50 INFO - 'tests': ['tp5n']}, 13:34:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:50 INFO - 'talos_options': ['--xperf_path', 13:34:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:50 INFO - 'tests': ['tp5n']}}, 13:34:50 INFO - 'talos.zip': {'path': '', 13:34:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:34:50 INFO - Running post-action listener: _resource_record_post_action 13:34:50 INFO - ##### 13:34:50 INFO - ##### Running create-virtualenv step. 13:34:50 INFO - ##### 13:34:50 INFO - Running pre-action listener: _resource_record_pre_action 13:34:50 INFO - Running main action method: create_virtualenv 13:34:50 INFO - Creating virtualenv /builds/slave/test/build/venv 13:34:50 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 13:34:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:34:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:34:50 INFO - Using real prefix '/usr' 13:34:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:34:50 INFO - Installing distribute.............................................................................................................................................................................................done. 13:34:52 INFO - Installing pip.................done. 13:34:52 INFO - Return code: 0 13:34:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:34:52 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')]} 13:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:52 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')]} 13:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:52 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 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:34:52 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 13:34:52 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 13:34:52 INFO - Using env: {'DISPLAY': ':0', 13:34:52 INFO - 'HOME': '/home/cltbld', 13:34:52 INFO - 'LANG': 'en_US.UTF-8', 13:34:52 INFO - 'LANGUAGE': 'en_US:en', 13:34:52 INFO - 'LOGNAME': 'cltbld', 13:34:52 INFO - 'MAIL': '/var/mail/cltbld', 13:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:52 INFO - 'MOZ_NO_REMOTE': '1', 13:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:52 INFO - 'NO_EM_RESTART': '1', 13:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:52 INFO - 'PWD': '/builds/slave/test', 13:34:52 INFO - 'SHELL': '/bin/bash', 13:34:52 INFO - 'SHLVL': '1', 13:34:52 INFO - 'TERM': 'linux', 13:34:52 INFO - 'TMOUT': '86400', 13:34:52 INFO - 'USER': 'cltbld', 13:34:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:52 INFO - '_': '/tools/buildbot/bin/python'} 13:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:52 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 13:34:52 INFO - Cleaning up... 13:34:53 INFO - Return code: 0 13:34:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:34:53 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')]} 13:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:53 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')]} 13:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:53 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 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:34:53 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 13:34:53 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 13:34:53 INFO - Using env: {'DISPLAY': ':0', 13:34:53 INFO - 'HOME': '/home/cltbld', 13:34:53 INFO - 'LANG': 'en_US.UTF-8', 13:34:53 INFO - 'LANGUAGE': 'en_US:en', 13:34:53 INFO - 'LOGNAME': 'cltbld', 13:34:53 INFO - 'MAIL': '/var/mail/cltbld', 13:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:53 INFO - 'MOZ_NO_REMOTE': '1', 13:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:53 INFO - 'NO_EM_RESTART': '1', 13:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:53 INFO - 'PWD': '/builds/slave/test', 13:34:53 INFO - 'SHELL': '/bin/bash', 13:34:53 INFO - 'SHLVL': '1', 13:34:53 INFO - 'TERM': 'linux', 13:34:53 INFO - 'TMOUT': '86400', 13:34:53 INFO - 'USER': 'cltbld', 13:34:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:53 INFO - '_': '/tools/buildbot/bin/python'} 13:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:53 INFO - Downloading/unpacking psutil>=0.7.1 13:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:34:55 INFO - Installing collected packages: psutil 13:34:55 INFO - Running setup.py install for psutil 13:34:55 INFO - building 'psutil._psutil_linux' extension 13:34:55 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 13:34:55 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 13:34:55 INFO - building 'psutil._psutil_posix' extension 13:34:55 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 13:34:55 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 13:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:34:55 INFO - Successfully installed psutil 13:34:55 INFO - Cleaning up... 13:34:55 INFO - Return code: 0 13:34:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:55 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 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:34:55 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 13:34:55 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 13:34:55 INFO - Using env: {'DISPLAY': ':0', 13:34:55 INFO - 'HOME': '/home/cltbld', 13:34:55 INFO - 'LANG': 'en_US.UTF-8', 13:34:55 INFO - 'LANGUAGE': 'en_US:en', 13:34:55 INFO - 'LOGNAME': 'cltbld', 13:34:55 INFO - 'MAIL': '/var/mail/cltbld', 13:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:55 INFO - 'MOZ_NO_REMOTE': '1', 13:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:55 INFO - 'NO_EM_RESTART': '1', 13:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:55 INFO - 'PWD': '/builds/slave/test', 13:34:55 INFO - 'SHELL': '/bin/bash', 13:34:55 INFO - 'SHLVL': '1', 13:34:55 INFO - 'TERM': 'linux', 13:34:55 INFO - 'TMOUT': '86400', 13:34:55 INFO - 'USER': 'cltbld', 13:34:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:55 INFO - '_': '/tools/buildbot/bin/python'} 13:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:34:55 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 13:34:55 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 13:34:55 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 13:34:55 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 13:34:55 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 13:34:55 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 13:34:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:34:57 INFO - Installing collected packages: mozsystemmonitor 13:34:57 INFO - Running setup.py install for mozsystemmonitor 13:34:57 INFO - Successfully installed mozsystemmonitor 13:34:57 INFO - Cleaning up... 13:34:58 INFO - Return code: 0 13:34:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:34:58 INFO - Using env: {'DISPLAY': ':0', 13:34:58 INFO - 'HOME': '/home/cltbld', 13:34:58 INFO - 'LANG': 'en_US.UTF-8', 13:34:58 INFO - 'LANGUAGE': 'en_US:en', 13:34:58 INFO - 'LOGNAME': 'cltbld', 13:34:58 INFO - 'MAIL': '/var/mail/cltbld', 13:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:58 INFO - 'MOZ_NO_REMOTE': '1', 13:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:58 INFO - 'NO_EM_RESTART': '1', 13:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:58 INFO - 'PWD': '/builds/slave/test', 13:34:58 INFO - 'SHELL': '/bin/bash', 13:34:58 INFO - 'SHLVL': '1', 13:34:58 INFO - 'TERM': 'linux', 13:34:58 INFO - 'TMOUT': '86400', 13:34:58 INFO - 'USER': 'cltbld', 13:34:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:58 INFO - '_': '/tools/buildbot/bin/python'} 13:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:58 INFO - Downloading/unpacking blobuploader==1.2.4 13:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:00 INFO - Downloading blobuploader-1.2.4.tar.gz 13:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:35:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:35:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:00 INFO - Downloading docopt-0.6.1.tar.gz 13:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:35:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:35:01 INFO - Running setup.py install for blobuploader 13:35:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:35:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:35:01 INFO - Running setup.py install for requests 13:35:01 INFO - Running setup.py install for docopt 13:35:01 INFO - Successfully installed blobuploader requests docopt 13:35:01 INFO - Cleaning up... 13:35:01 INFO - Return code: 0 13:35:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:35:01 INFO - Using env: {'DISPLAY': ':0', 13:35:01 INFO - 'HOME': '/home/cltbld', 13:35:01 INFO - 'LANG': 'en_US.UTF-8', 13:35:01 INFO - 'LANGUAGE': 'en_US:en', 13:35:01 INFO - 'LOGNAME': 'cltbld', 13:35:01 INFO - 'MAIL': '/var/mail/cltbld', 13:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:01 INFO - 'MOZ_NO_REMOTE': '1', 13:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:01 INFO - 'NO_EM_RESTART': '1', 13:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:01 INFO - 'PWD': '/builds/slave/test', 13:35:01 INFO - 'SHELL': '/bin/bash', 13:35:01 INFO - 'SHLVL': '1', 13:35:01 INFO - 'TERM': 'linux', 13:35:01 INFO - 'TMOUT': '86400', 13:35:01 INFO - 'USER': 'cltbld', 13:35:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:01 INFO - '_': '/tools/buildbot/bin/python'} 13:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:01 INFO - Running setup.py (path:/tmp/pip-AlDhyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:01 INFO - Running setup.py (path:/tmp/pip-oVbxiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:02 INFO - Running setup.py (path:/tmp/pip-PcbVm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:02 INFO - Running setup.py (path:/tmp/pip-6BHKxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:02 INFO - Running setup.py (path:/tmp/pip-zu_L9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:02 INFO - Running setup.py (path:/tmp/pip-yX1_5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:02 INFO - Running setup.py (path:/tmp/pip-ZMUaQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:02 INFO - Running setup.py (path:/tmp/pip-vKvJXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:02 INFO - Running setup.py (path:/tmp/pip-2Q7V1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:02 INFO - Running setup.py (path:/tmp/pip-q0ohPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:02 INFO - Running setup.py (path:/tmp/pip-5dqBlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:02 INFO - Running setup.py (path:/tmp/pip-Md1x5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:02 INFO - Running setup.py (path:/tmp/pip-hLGBB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:02 INFO - Running setup.py (path:/tmp/pip-OTGJfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:02 INFO - Running setup.py (path:/tmp/pip-oLQXf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:02 INFO - Running setup.py (path:/tmp/pip-nZ15pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:03 INFO - Running setup.py (path:/tmp/pip-26VqOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:35:03 INFO - Running setup.py install for manifestparser 13:35:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Running setup.py install for mozcrash 13:35:03 INFO - Running setup.py install for mozdebug 13:35:03 INFO - Running setup.py install for mozdevice 13:35:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Running setup.py install for mozfile 13:35:03 INFO - Running setup.py install for mozhttpd 13:35:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Running setup.py install for mozinfo 13:35:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Running setup.py install for mozInstall 13:35:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Running setup.py install for mozleak 13:35:03 INFO - Running setup.py install for mozlog 13:35:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:35:04 INFO - Running setup.py install for moznetwork 13:35:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:35:04 INFO - Running setup.py install for mozprocess 13:35:04 INFO - Running setup.py install for mozprofile 13:35:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:35:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:35:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:35:04 INFO - Running setup.py install for mozrunner 13:35:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:35:04 INFO - Running setup.py install for mozscreenshot 13:35:04 INFO - Running setup.py install for moztest 13:35:04 INFO - Running setup.py install for mozversion 13:35:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:35:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:35:04 INFO - Cleaning up... 13:35:04 INFO - Return code: 0 13:35:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:04 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 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:35:04 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 13:35:04 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 13:35:04 INFO - Using env: {'DISPLAY': ':0', 13:35:04 INFO - 'HOME': '/home/cltbld', 13:35:04 INFO - 'LANG': 'en_US.UTF-8', 13:35:04 INFO - 'LANGUAGE': 'en_US:en', 13:35:04 INFO - 'LOGNAME': 'cltbld', 13:35:04 INFO - 'MAIL': '/var/mail/cltbld', 13:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:04 INFO - 'MOZ_NO_REMOTE': '1', 13:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:04 INFO - 'NO_EM_RESTART': '1', 13:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:04 INFO - 'PWD': '/builds/slave/test', 13:35:04 INFO - 'SHELL': '/bin/bash', 13:35:04 INFO - 'SHLVL': '1', 13:35:04 INFO - 'TERM': 'linux', 13:35:04 INFO - 'TMOUT': '86400', 13:35:04 INFO - 'USER': 'cltbld', 13:35:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:04 INFO - '_': '/tools/buildbot/bin/python'} 13:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:05 INFO - Running setup.py (path:/tmp/pip-rTZmg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:05 INFO - Running setup.py (path:/tmp/pip-uBYvDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:05 INFO - Running setup.py (path:/tmp/pip-8_r5Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:05 INFO - Running setup.py (path:/tmp/pip-nTzqWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:05 INFO - Running setup.py (path:/tmp/pip-LTEcic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:05 INFO - Running setup.py (path:/tmp/pip-lL5FJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:05 INFO - Running setup.py (path:/tmp/pip-HE9TPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:05 INFO - Running setup.py (path:/tmp/pip-l6Pno1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:05 INFO - Running setup.py (path:/tmp/pip-7zzO2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:05 INFO - Running setup.py (path:/tmp/pip-r2fmHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:05 INFO - Running setup.py (path:/tmp/pip-F5QUM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:05 INFO - Running setup.py (path:/tmp/pip-_xgFtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:05 INFO - Running setup.py (path:/tmp/pip-mu1L6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:06 INFO - Running setup.py (path:/tmp/pip-UvPBR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:06 INFO - Running setup.py (path:/tmp/pip-oIMEPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:06 INFO - Running setup.py (path:/tmp/pip-WtpiEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:06 INFO - Running setup.py (path:/tmp/pip-6TcH8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:35:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:08 INFO - Downloading blessings-1.6.tar.gz 13:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:35:08 INFO - Installing collected packages: blessings 13:35:08 INFO - Running setup.py install for blessings 13:35:08 INFO - Successfully installed blessings 13:35:08 INFO - Cleaning up... 13:35:08 INFO - Return code: 0 13:35:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:08 INFO - Reading from file tmpfile_stdout 13:35:08 INFO - Current package versions: 13:35:08 INFO - argparse == 1.2.1 13:35:08 INFO - blessings == 1.6 13:35:08 INFO - blobuploader == 1.2.4 13:35:08 INFO - docopt == 0.6.1 13:35:08 INFO - manifestparser == 1.1 13:35:08 INFO - mozInstall == 1.12 13:35:08 INFO - mozcrash == 0.17 13:35:08 INFO - mozdebug == 0.1 13:35:08 INFO - mozdevice == 0.48 13:35:08 INFO - mozfile == 1.2 13:35:08 INFO - mozhttpd == 0.7 13:35:08 INFO - mozinfo == 0.9 13:35:08 INFO - mozleak == 0.1 13:35:08 INFO - mozlog == 3.1 13:35:08 INFO - moznetwork == 0.27 13:35:08 INFO - mozprocess == 0.22 13:35:08 INFO - mozprofile == 0.28 13:35:08 INFO - mozrunner == 6.11 13:35:08 INFO - mozscreenshot == 0.1 13:35:08 INFO - mozsystemmonitor == 0.0 13:35:08 INFO - moztest == 0.7 13:35:08 INFO - mozversion == 1.4 13:35:08 INFO - psutil == 3.1.1 13:35:08 INFO - requests == 1.2.3 13:35:08 INFO - wsgiref == 0.1.2 13:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35: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')]} 13:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35: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')]} 13:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:08 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 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:35:08 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 13:35:08 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 13:35:08 INFO - Using env: {'DISPLAY': ':0', 13:35:08 INFO - 'HOME': '/home/cltbld', 13:35:08 INFO - 'LANG': 'en_US.UTF-8', 13:35:08 INFO - 'LANGUAGE': 'en_US:en', 13:35:08 INFO - 'LOGNAME': 'cltbld', 13:35:08 INFO - 'MAIL': '/var/mail/cltbld', 13:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:08 INFO - 'MOZ_NO_REMOTE': '1', 13:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:08 INFO - 'NO_EM_RESTART': '1', 13:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:08 INFO - 'PWD': '/builds/slave/test', 13:35:08 INFO - 'SHELL': '/bin/bash', 13:35:08 INFO - 'SHLVL': '1', 13:35:08 INFO - 'TERM': 'linux', 13:35:08 INFO - 'TMOUT': '86400', 13:35:08 INFO - 'USER': 'cltbld', 13:35:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:08 INFO - '_': '/tools/buildbot/bin/python'} 13:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 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)) 13:35:08 INFO - Cleaning up... 13:35:08 INFO - Return code: 0 13:35:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:35: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')]} 13:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35: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')]} 13:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:08 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 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:35:08 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 13:35:08 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 13:35:08 INFO - Using env: {'DISPLAY': ':0', 13:35:08 INFO - 'HOME': '/home/cltbld', 13:35:08 INFO - 'LANG': 'en_US.UTF-8', 13:35:08 INFO - 'LANGUAGE': 'en_US:en', 13:35:08 INFO - 'LOGNAME': 'cltbld', 13:35:08 INFO - 'MAIL': '/var/mail/cltbld', 13:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:08 INFO - 'MOZ_NO_REMOTE': '1', 13:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:08 INFO - 'NO_EM_RESTART': '1', 13:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:08 INFO - 'PWD': '/builds/slave/test', 13:35:08 INFO - 'SHELL': '/bin/bash', 13:35:08 INFO - 'SHLVL': '1', 13:35:08 INFO - 'TERM': 'linux', 13:35:08 INFO - 'TMOUT': '86400', 13:35:08 INFO - 'USER': 'cltbld', 13:35:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:08 INFO - '_': '/tools/buildbot/bin/python'} 13:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:09 INFO - Downloading/unpacking jsonschema 13:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:35:10 INFO - Downloading/unpacking functools32 (from jsonschema) 13:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:35:11 INFO - warning: no files found matching '*.txt' 13:35:11 INFO - no previously-included directories found matching 'build' 13:35:11 INFO - no previously-included directories found matching 'dist' 13:35:11 INFO - no previously-included directories found matching '.git*' 13:35:11 INFO - Installing collected packages: jsonschema, functools32 13:35:11 INFO - Running setup.py install for functools32 13:35:11 INFO - warning: no files found matching '*.txt' 13:35:11 INFO - no previously-included directories found matching 'build' 13:35:11 INFO - no previously-included directories found matching 'dist' 13:35:11 INFO - no previously-included directories found matching '.git*' 13:35:11 INFO - Successfully installed jsonschema functools32 13:35:11 INFO - Cleaning up... 13:35:11 INFO - Return code: 0 13:35:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:35: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')]} 13:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35: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')]} 13:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:11 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 0x7f723f2f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', '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 13:35:11 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 13:35:11 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 13:35:11 INFO - Using env: {'DISPLAY': ':0', 13:35:11 INFO - 'HOME': '/home/cltbld', 13:35:11 INFO - 'LANG': 'en_US.UTF-8', 13:35:11 INFO - 'LANGUAGE': 'en_US:en', 13:35:11 INFO - 'LOGNAME': 'cltbld', 13:35:11 INFO - 'MAIL': '/var/mail/cltbld', 13:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:11 INFO - 'MOZ_NO_REMOTE': '1', 13:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:11 INFO - 'NO_EM_RESTART': '1', 13:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:11 INFO - 'PWD': '/builds/slave/test', 13:35:11 INFO - 'SHELL': '/bin/bash', 13:35:11 INFO - 'SHLVL': '1', 13:35:11 INFO - 'TERM': 'linux', 13:35:11 INFO - 'TMOUT': '86400', 13:35:11 INFO - 'USER': 'cltbld', 13:35:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:11 INFO - '_': '/tools/buildbot/bin/python'} 13:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:11 INFO - Downloading/unpacking flake8 13:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:35:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:35:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:13 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 13:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:35:14 INFO - no previously-included directories found matching 'docs/_build' 13:35:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:35:14 INFO - Running setup.py install for pep8 13:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:35:14 INFO - no previously-included directories found matching 'docs/_build' 13:35:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:35:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:35:14 INFO - Cleaning up... 13:35:14 INFO - Return code: 0 13:35:14 INFO - Running post-action listener: _resource_record_post_action 13:35:14 INFO - Running post-action listener: _start_resource_monitoring 13:35:14 INFO - Starting resource monitoring. 13:35:14 INFO - ##### 13:35:14 INFO - ##### Running install step. 13:35:14 INFO - ##### 13:35:14 INFO - Running pre-action listener: _resource_record_pre_action 13:35:14 INFO - Running main action method: install 13:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:14 INFO - Reading from file tmpfile_stdout 13:35:14 INFO - Detecting whether we're running mozinstall >=1.0... 13:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:35:14 INFO - Reading from file tmpfile_stdout 13:35:14 INFO - Output received: 13:35:14 INFO - Usage: mozinstall [options] installer 13:35:14 INFO - Options: 13:35:14 INFO - -h, --help show this help message and exit 13:35:14 INFO - -d DEST, --destination=DEST 13:35:14 INFO - Directory to install application into. [default: 13:35:14 INFO - "/builds/slave/test"] 13:35:14 INFO - --app=APP Application being installed. [default: firefox] 13:35:14 INFO - mkdir: /builds/slave/test/build/application 13:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:35:30 INFO - Reading from file tmpfile_stdout 13:35:30 INFO - Output received: 13:35:30 INFO - /builds/slave/test/build/application/firefox/firefox 13:35:30 INFO - Running post-action listener: _resource_record_post_action 13:35:30 INFO - ##### 13:35:30 INFO - ##### Running run-tests step. 13:35:30 INFO - ##### 13:35:30 INFO - Running pre-action listener: _resource_record_pre_action 13:35:30 INFO - Running main action method: run_tests 13:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:35:30 INFO - Python 2.7.3 13:35:30 INFO - Return code: 0 13:35:30 INFO - grabbing minidump binary from tooltool 13:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c410>, '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 0x122d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x122d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:35:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:35:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:35:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:35:30 INFO - Return code: 0 13:35:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:35:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:35:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:35:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:35:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:35:31 INFO - Return code: 0 13:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 13:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 13:35:31 INFO - Using env: {'DISPLAY': ':0', 13:35:31 INFO - 'HOME': '/home/cltbld', 13:35:31 INFO - 'LANG': 'en_US.UTF-8', 13:35:31 INFO - 'LANGUAGE': 'en_US:en', 13:35:31 INFO - 'LOGNAME': 'cltbld', 13:35:31 INFO - 'MAIL': '/var/mail/cltbld', 13:35:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:35:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:31 INFO - 'MOZ_NO_REMOTE': '1', 13:35:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:31 INFO - 'NO_EM_RESTART': '1', 13:35:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:31 INFO - 'PWD': '/builds/slave/test', 13:35:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:35:31 INFO - 'SHELL': '/bin/bash', 13:35:31 INFO - 'SHLVL': '1', 13:35:31 INFO - 'TERM': 'linux', 13:35:31 INFO - 'TMOUT': '86400', 13:35:31 INFO - 'USER': 'cltbld', 13:35:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161', 13:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:31 INFO - '_': '/tools/buildbot/bin/python'} 13:35:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 13:35:31 INFO - mozversion application_buildid: 20160425103006 13:35:31 INFO - mozversion application_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:35:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:35:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:35:31 INFO - mozversion application_name: Firefox 13:35:31 INFO - mozversion application_remotingname: firefox-dev 13:35:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:35:31 INFO - mozversion application_vendor: Mozilla 13:35:31 INFO - mozversion application_version: 48.0a2 13:35:31 INFO - mozversion platform_buildid: 20160425103006 13:35:31 INFO - mozversion platform_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:35:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:35:31 INFO - mozversion platform_version: 48.0a2 13:35:31 INFO - using testdate: 1461616531 13:35:31 INFO - actual date: 1461616531 13:35:31 INFO - starting webserver on 'localhost:37640' 13:35:31 INFO - SUITE-START | Running 2 tests 13:35:31 INFO - TEST-START | dromaeo_css 13:35:31 INFO - operating with platform_type : linux_ 13:35:31 INFO - Initialising browser for dromaeo_css test... 13:35:31 INFO - TEST-INFO | started process 32450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNR05XF/profile http://localhost:37640/getInfo.html) 13:35:35 INFO - PROCESS | 32450 | 13:35:35 INFO - PROCESS | 32450 | (process:32528): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:35:35 INFO - PROCESS | 32450 | __metrics Screen width/height:1600/1200 13:35:35 INFO - PROCESS | 32450 | colorDepth:24 13:35:35 INFO - PROCESS | 32450 | Browser inner width/height: 1024/697 13:35:35 INFO - PROCESS | 32450 | __metrics 13:35:36 ERROR - PROCESS | 32450 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:35:37 INFO - TEST-INFO | 32450: exit 0 13:35:37 INFO - Browser initialized. 13:35:37 INFO - Running cycle 1/1 for dromaeo_css test... 13:35:37 INFO - TEST-INFO | started process 32579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNR05XF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:35:38 INFO - PROCESS | 32579 | 13:35:38 INFO - PROCESS | 32579 | (process:32647): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:35:48 INFO - PROCESS | 32579 | RSS: Main: 152764416 13:35:48 INFO - PROCESS | 32579 | 13:36:38 INFO - PROCESS | 32579 | 1461616598506 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] 13:38:46 INFO - PROCESS | 32579 | Cycle 1(1): loaded http://localhost:37640/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37640/tests/dromaeo/cssquery-ext.html) 13:38:47 INFO - PROCESS | 32579 | RSS: Main: 155774976 13:38:47 INFO - PROCESS | 32579 | 13:41:49 INFO - PROCESS | 32579 | Cycle 1(1): loaded http://localhost:37640/tests/dromaeo/cssquery-ext.html (next: http://localhost:37640/tests/dromaeo/cssquery-jquery.html) 13:41:49 INFO - PROCESS | 32579 | RSS: Main: 154415104 13:41:49 INFO - PROCESS | 32579 | 13:44:51 INFO - PROCESS | 32579 | Cycle 1(1): loaded http://localhost:37640/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37640/tests/dromaeo/cssquery-mootools.html) 13:44:52 INFO - PROCESS | 32579 | RSS: Main: 153972736 13:44:52 INFO - PROCESS | 32579 | 13:47:54 INFO - PROCESS | 32579 | Cycle 1(1): loaded http://localhost:37640/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37640/tests/dromaeo/cssquery-prototype.html) 13:47:54 INFO - PROCESS | 32579 | RSS: Main: 153534464 13:47:54 INFO - PROCESS | 32579 | 13:50:57 INFO - PROCESS | 32579 | Cycle 1(1): loaded http://localhost:37640/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37640/tests/dromaeo/cssquery-yui.html) 13:50:57 INFO - PROCESS | 32579 | RSS: Main: 154619904 13:50:57 INFO - PROCESS | 32579 | 13:53:59 INFO - PROCESS | 32579 | Cycle 1(1): loaded http://localhost:37640/tests/dromaeo/cssquery-yui.html (next: http://localhost:37640/tests/dromaeo/cssquery-dojo.html) 13:54:00 INFO - PROCESS | 32579 | RSS: Main: 155947008 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - PROCESS | 32579 | __start_tp_report 13:54:00 INFO - PROCESS | 32579 | _x_x_mozilla_page_load 13:54:00 INFO - PROCESS | 32579 | _x_x_mozilla_page_load_details 13:54:00 INFO - PROCESS | 32579 | |i|pagename|runs| 13:54:00 INFO - PROCESS | 32579 | |0;dojo.html;3372.4941258811177;3465.1337165708583;3472.2187507810763;3503.6846683798453;3506.9298614027734;5747.798827041054;5767.106098554731;5804.593678442506;5836.037053886114;5839.883202335956;5704.857378565538;5772.480476757091;5789.681567513796;5823.970880145604;5826.563007774413;5208.453112423198;5278.973605131969;5310.273248038959;5319.787208511655;5329.840104796843;5231.790728370861;5357.223202635615;5412.621116521845;5416.187571864212;5445.264889239961;5206.167013277876;5278.762455689484;5316.9202461963105;5406.405295417501;5425.457454254562;5295.232191332255;5322.148456246982;5325.760340784635;5328.946710532922;5337.252784610138;5186.196139598331;5228.08508511009;5240.161574148118;5279.155335146396;5288.762005709714;5442.156465747816;5545.77816887324;5562;5566.2207290979295;5570.442955704438;6094.116353128816;6123.201770564369;6125.143885071339;6130.019196928514;6161.4146656067605;6220.1913751212505;6227.408396202399;6252.6561039142825;6265.248170219603;6266.185395898549;5685.090385538294;5782.421757824184;5792.7972520961985;5798.188253644493;5874.559408044371;6278.246610406781;6291.245050593958;6333.493320534346;6353.14232578596;6354.682265886687;5999;6026.6986650667295;6068.393160683984;6069.393060693896;6077;5984.461398474158;6089.512838972872;6125.235451818339;6140.3552626974415;6165.506759459233;6114.293392522066;6116.031445914963;6116.774791473579;6132.324915438597;6150.10823430609;6121.462493334886;6127.803048439805;6132.294322189902;6141.148492690724;6143.139960405547;4526.751028693454;4615.492295847454;4667.369905062773;4684.461286951976;4685.156671799041;4103.630673239363;4118.258713431611;4119.032027473541;4138.255114079434;4158.397032430341;5718;5816.12758086282;5821.301443826768;5832.8541786454825;5866.12008198765;6039.7282122304605;6064.36324185963;6089;6150.323464418911;6172.722227499773;5874.5887787854435;5874.73563689635;5876.970615146897;5913.379095195029;5951.226340575698;5206.193040078794;5233.4243233244315;5236.9738151309;5245.895082098336;5251.973740131275;6178.845528861814;6410.903836442457;6468.8059358219325;6480.416762491398;6489.253735820441;6148.200733904564;6177.073438984188;6184.721687524162;6193.318734939063;6193.566450348432;6182.505399567934;6412.03819427071;6420.357964203729;6420.486361091195;6422.775202867877;5988.28140623128;5996.190514280516;6071.787487437919;6099.3290738017895;6115.755369785159;6126.853582554517;6151.15640141876;6172.8765424690355;6180.227471566054;6199.597026193283;5930.377310382521;5935.792247271324;5998.4601385875485;6003;6018.849528761816;5882.441168089024;5977.193078934462;6042;6060.030964390986;6070.544709146743;5811;5818;5843.649381037151;5854.297484301911;5859.707014649336;5849.327327357239;5957.255343082114;5996.220491336098;6000.939990600038;6017.308009578955;5784.797532086357;5801.883962320814;5821.27234095738;5838.211841401527;5838.854028649148 13:54:00 INFO - PROCESS | 32579 | |1;ext.html;567.9403662615425;658.1575583253434;660.7092879133182;667.1493845347181;683.7777722240273;39589.4061589076;41025.38461923073;41121.971950701285;41283;41347;40704.38943415844;41083.58916410835;41154.794226028826;41391.58608413915;41450.792746036306;8846.24806891415;9006;9055.909440905605;9063.274938004977;9068.410553314046;8962.193402593797;9027.232685221765;9068.682596109138;9079.455232686027;9085.13691199335;8925.509096999695;8940.776480588005;8996.145366190201;8998.86501702475;9004.324675649319;9053.909460905405;9079.18287354138;9146.131117543822;9150.176484116428;9183.08169183083;9022.593983270703;9068.410553314014;9083.954580227057;9113.81772364549;9145.771355716093;39863;40640.796796016126;40655.39016914749;40688.186236275105;40846.79576602128;3492.4761285807076;3662.7619204751604;3709.4621279914263;3759.8684046058256;3791.4881490998637;32952.02287862712;33140;33611.15972100717;33986.32027359464;33990.320193596235;4501.167284052428;4650.465196502411;4673.929891051637;4680.485146633868;4703.341532185496;330604;330930;334068;335161.99999999756;335181;36578.26843463116;65801;66751.33248667451;66800.33199668038;66966.330336696;37407;37582.8120859394;37610.62389376126;37720;37724.62275377266;14083.436662533384;14276.286185690882;14336.56990290293;14351.928240358731;14366.712665746627;11786.410679465993;11889.346085965182;11895.16733828641;11902.88097119035;11950.223235489666;9050.456972581665;9123.452592844318;9236.261099112055;9251.444913305224;9260.259179265642;3465.497502862071;3577.874774382884;3600.459931010317;3602;3623.7282203834816;946.711253067821;1007.8488226766044;1013.9910788765226;1083.550326614462;1094.698957786615;33008.83495582555;33708.49437258443;33801.49297760487;34057;34879.4768078479;1175.4534141624185;1181.6573193773709;1182.6629410617932;1253.9122261441794;1286.1125823181974;17742.29030838778;18085.909570452328;18201.908990454962;18387.356442524713;18513.166907489194;327409;340053;344505;344835;530045;56386.154207686915;57632.71183644139;57704;57716.711416442646;58230.7088464555;1394.5607133752835;1432.5201057645597;1440.6902515959118;1462.656275775192;1480.222882986419;30750.84624576863;31960.52059219067;32142.395594126123;32513.674863251064;32764.344713106082;55170;55919;55931.44068559262;56019.15971260516;56084;437202;437298;440585;440659;440976;31622.209444764067;31799.52300715445;31950;31996.5200521997;32202.516962246053;51641.48358516367;52265.21602176046;53070.2039469416;53438.73280633572;54210.186847198114;43451.78274108609;44817.551824481336;44920.55079449164;45364.54635453603;46126.30810537912;35343.46984795179;38071.809640951615;39236.80381598074;39250;43663.345049824915;43071.56928430801;43341.783291083346;44314;44373.77813110914;44393.55606443894;36899;36998.8150059248;37151.81424092862;37307;37988.43017354687;29100.513250653436;29624.407511850073;29687.406251875273;30134.54798177985;30468.84765576158 13:54:00 INFO - PROCESS | 32579 | |2;jquery.html;376.26252545011795;383.6566273185498;385.27568171836947;385.7299890076945;388.12671489149415;17487.825121748778;19158.80841191591;19770.209191632337;20056.097475613577;20070.698939515918;15372.308246128923;15794.131322777243;15908.681826363494;15918;15981.200939953014;5542.224088627595;5711.114777209539;5719.14212868069;5766.250387449626;5787.710614469281;4045.2111838191563;6073.453389194971;6340.112384266206;6349.079383489415;6361.3638636136475;5998.310194327664;6312.053192021211;6314.526410519206;6314.6842657867155;6319.74721011159;6237.438630523252;6294.307626161119;6325.588836725598;6344.968275158618;6351.047342898579;5349.786008559653;5443.673379597237;5513.173024046385;5541.445855414427;5584.664920104807;10725.463726813628;11278.15413843965;11363.886361136365;22391.440213994618;22522.436939076655;2305.5158416732506;2346.1905642553293;2362.881855907198;2565.948681026369;2809.929751756202;8548.658053677907;8839.867401988975;9068.093190680946;9092.954535227347;9142.634294628207;2014.63736527425;2038.9184432622826;2049.723287356203;2068.958620827575;2119.9152033918626;85470.57264713699;87766.56116719439;89317;90375.54812225963;90873.54563227207;10231.488425578691;10334.483275836328;10431.634892778717;10469.581216751398;10518.842217366746;14016.369263383172;14057.226852523005;14073.366698498592;14129.929350353388;14167;7618.923810761932;7885.250901164381;7968.721094761656;7984.6806127754235;8054.879176812353;7560;7770.339521140766;7789.805254868674;7794.610269486503;7795.649195786204;3623.0942264433893;3952.2095580883365;4045.838166473367;4337.284348082531;4375.868723938287;1763.982360176382;1786.1872847854195;1831.716084006981;1833.8166183381823;1835.8898466092078;379.6374462388412;384.0456465682776;388.25455126157283;393.5828022296375;952.9332946693803;9134.954325228464;9573.18627916635;16973;18960.715589266172;19234.80765192358;1033.3489901362243;1036.212478516318;1045.6235755128148;1063.8563793887727;1115.041064684371;9743.220542356594;10192.694219173436;10240.590376385011;10297.485125743682;10299.794004119876;407753;411972;415621;415631;564014;97196.51401742946;101632.49183754182;104969;105323;106338;1082.410086502858;1121.9382933938712;1125.8198688210011;1128.5880653561392;1148.6094727792424;15740.212989350715;15830.050196988217;15884;15921.601959951095;16095.275712593195;41097.178056439305;41444.585554144076;41969.631843581636;42374.305027798546;42607.57392426036;60174.699126504085;61224.693876530335;61275.69362153161;62181.68909155425;62944.37055629385;7292.270772922665;7506.662200201114;7604;7685.193054729397;7689.538627682357;8773.692920747742;11551.364674942959;12162.270263784201;12455.439505222106;12565.18326308787;11130.554777808797;11181.776364472827;11246.83129753038;11464.541418343173;11542.94228528852;10672.946635266773;10748.408837514013;10757.246992710749;10781.137508999105;10825.025747682746;11301.208915375844;11348.262362946381;11374.545018199511;11397.202195846543;11409.885901140882;7571.507851989603;7645.923540764521;7713.691452341844;7740.032495938008;7956.189089168046;10386.221033422373;10845.511951962339;10912.781744365227;11376.94311528437;11515.36665483373 13:54:00 INFO - PROCESS | 32579 | |3;mootools.html;1452.9128252304859;1537.8769698424128;1725.8015328237257;1841.300305883764;1871.7847447543536;7442.516236444627;7909.485883417574;8115.513069215844;8578;8593.398462107654;8203.589820508965;8302.086770455246;8312.459690120138;8338.166183381658;8345.874811877811;2264.105678257083;2278.3278932714807;2287.8512896661746;2292.323764489471;2295.9655605165935;2275.544891021794;2290.725112986444;2299.3446867642724;2306.723193216808;2317.884105794712;2327.976720232801;2344.5193735284224;2346.495503466754;2354.8233882458885;2373.560891235127;2271.8636881787147;2274.215395688493;2281.760415156418;2284.6001949658744;2289.3132060381818;2270.693456383384;2277.271273192579;2282.691836602054;2285.6000199965106;2288.702468679078;8440.451370660887;8448.155184481564;8491.61787719554;8514.914850851474;8563.828723425559;4755.809767609291;4953.876153096166;4962.106820772259;4972.925406118911;4975.651704380659;3277.9836100819343;3334.3498017886523;3437.415639341318;3457.9654203457894;3486.250456151914;1114.359243435028;1115.670877091252;1126.555010770749;1157.8263260510907;1162.8546431696038;11307.208495405324;11328;11432.885671143265;11458.713532161595;11469.541218351256;4457.465104187519;4494.988627558773;4572.1312950539295;4621.60716339115;4639.791209395586;8772.912270877338;8827.16141966512;8834.381593288408;8839.779005524784;8871.556422178865;4741.407324084489;4769;4780.880477988008;4784.091022705675;4798.47216806151;4025;4329.523752387235;4405.449318835145;4445.555444455528;4455.821767129279;3723.1436769543157;3766.472693822867;3845.9807700961314;3865.072382628205;3875.244327356195;1145.8854114588476;1150.3040660400504;1150.4362862197631;1151.9366434846163;1154.5554961339776;925.796324808541;1069.6042464288107;1084.734240111162;1101.0750969185763;1119.216548416112;5839.357670656224;5891.3224979127945;6062.560784391627;6110.358412366726;6239.032949892774;417.62205204290166;417.6387424877459;419.6810424077662;424.5584592024322;433.09915376017807;4222;4265.466816647919;4335.739855608674;4343.457067866517;4371.213181627338;10165.4917254137;10400.47997600117;10556.102731267774;10699;10709.678709638723;10156.847647285296;10443.895561044292;10522.684319470429;10569.947150264354;10601.787964240671;7877.487963282369;7880.211978802074;7918.129005809241;7987.480813747088;7998.680052797939;5961.463468287875;6008.699565021644;6057.061155520725;6211.409916057967;6251.531135164972;9188.632454702005;9742.269329800434;9864.901350986398;9881.258905582254;9889.802203956024;9322.347435679709;9390.060993900828;9520.0479952007;9527.09492598202;9600.615975360908;7070.964645176947;7136.4290856730295;7395.7041718330665;7479.813004674709;7639.923600763921;8115;8129.715459958873;8200.138985406686;8244.958775206085;8259.587020649064;6886.414654754201;7036.824079397851;7062.682179302046;7156.355927966508;7162.427005839624;7419.183889772013;7529.322360987538;7563.886541701989;7600.650206047553;7624.466287359832;6389.48884089281;6452.032195170762;6492.766374388851;6507.544471886922;6508.316626754312;5212.488856350274;5215.634905556726;5252.400678306584;5279.788808447619;5360.249565060816;5092.541671249605;5185.662931909414;5196.841742535108;5293.576513878804;5363.704996225245 13:54:00 INFO - PROCESS | 32579 | |4;prototype.html;297.0938637156673;305.8058133085491;311.0109850674853;312.935848151129;314.7246159610341;5594.412586678402;5680.573956953224;5720.828375148747;5781.855453613656;5832.154337621042;5704.857378565538;5732.541396688265;5743.913841292384;5757.481826635602;5770.971145144279;4371.300591905296;4371.912561748763;4377.496587892401;4393.2970724684055;4394.582514661102;4095.856645017425;4323.610875021247;4325.048489332342;4363.978180109095;4371.519132895379;4227.534971153171;4245.023644561753;4258.850940217093;4263.467066616673;4280.507741609724;4266.488021437432;4278.7218830776055;4279.251131052085;4279.529251782302;4293.785310734482;3539.911502212465;3683.723720720957;3712.535933008374;3714.0900479382453;3732.794696291703;5472;5481.671099734029;5515.944840551583;5519.724013799294;5521.834344969617;4857.417109946794;4867.612730371862;4890.217565189588;4890.31284206948;4914.459409464956;5655.179998900177;5940.465358117747;5941.465268125846;5949.702514874239;5960.254968128984;4026.979865100685;4030.1536677297804;4042.6159514846045;4050.9189816203807;4053.0677944073027;6258.624482531062;6262.718177682015;6274.749010039593;6323.462505687022;6351.2060992375955;4070.4911886014247;4148.605882441163;4155.480564929384;4161.2509748245;4184.644305234028;4194;4210.2842516772225;4212.726172798758;4222.746635201897;4230.407742915994;4877.780499877514;4895.559399654048;4939.110960027229;4954.563176678723;4966.428860681068;5881.617694849907;6000.519958403317;6033.698315084228;6059.757609695563;6066.605670631395;1495.461633811827;1501.9561404823762;1504.368165370547;1506.314626844805;1511.146202395665;979.6326377608397;991.7371896447447;1000.3597697473623;1002.6691191906654;1009.3799451879628;6293.276273228637;6304.211973503312;6317.399847014526;6322.778702745474;6327.335629758901;6591.373819487141;6608.735650574019;6627.138471998609;6705.1283333166375;6709.362610552087;6092.482139018144;6281.340459251713;6306.49548036156;6308.842278943063;6313.810585682437;3556.484309775068;3581.3732596795458;3581.6239294874185;3587.4260118380935;3590.0254859827514;6234.314225435199;6469.385408386196;6527.34726527353;6539.215294164731;6944.756933507303;6338.58799178052;6383.329750376143;6416.486681065504;6442.7436649852825;6453.806385808433;6324.494040476751;6459.089932711517;6483.157189565326;6515.641639709766;6524.510661700391;6245.28179259391;6245.8750824982335;6253.562250642593;6268.247810262797;6322.2729386119345;5848.56135789826;6127.264728232641;6131.816045518642;6145.019665462337;6150.661713605795;6190.81427557174;6435.613863168225;6570.145881035435;6596.80209593713;6604.768833090819;4005.259027079883;4065.1666408385618;4095.5290141634096;4097.160082183085;4117.958820411877;6147.784827531015;6172.166757487861;6178.567500274938;6195.845103872439;6200.968995154995;5751.712414379348;5883;5950.761969521343;5972.402759723993;5978.491828194652;5916.73374698131;5936.22829032223;5946.137810017437;5961.791337303173;5972.522198224218;5699.34457537372;5802.158686990447;5804.970975145097;5834.329052159056;5859.091840764689;5725.713714314351;6099.207103076572;6131.356207598138;6152.846178845564;6153.323134455296;5927.199828023162;5928.436798504135;5949.553783466171;5989.550783691154;5997.490213331916 13:54:00 INFO - PROCESS | 32579 | |5;yui.html;817.619806789843;854.1373213054817;885.6501681835675;913.9908600913989;918.0177210384886;13876.444942202312;14724.852751472483;15119.546413607583;15187.633113019827;15207.619809504768;13995.440182392693;13999.720005599882;14017.15897046178;14035.649108772286;14097.506587269447;723.5622448418696;858.8539948208788;881.497546398553;881.5900606218107;884.8893888263967;885.0662551008684;894.4365050018479;896.1665650944619;896.1665650944619;900.4012331799378;930.8836395450569;934.3552948465536;936.7236665183788;940.2947789158131;941.6139382853031;930.1303281431815;931.8136372725414;933.5099072986668;934.9345545811796;939.0327962198912;685.6571714142929;685.8868286732733;686.6978529447077;689.0869597782957;690.4752388185016;12001.459934302977;12016;12020.63938081859;12061.155719099666;12117.091218158585;14302;14383.568492945229;14526.418943242257;14631.41474341025;14701.632459188499;12075.939620301842;12108;12187.573434929735;12229.93885030578;12378.75242495154;3995.960040399588;4012.779297138656;4055.8986025349604;4075.572064933169;4102.630763231294;56245;57612;57762.71118644422;59159.704201479144;59621.10568341478;11428.428578571038;11533.423328833525;11665.183437159318;11860.762784744256;12024.819627705592;21237.150513979577;21249;21252.893735531223;21349.14603415846;21404.678929816066;8186.549739764251;8225.753227403187;8282.792930176794;8384.287335576544;8626.956865215634;4913.238448040559;4976.353074100344;5034.697918124924;5042.243663450512;5042.974785126051;3456.2914602506426;3569.089882080053;3591.174029973121;3595.748297619194;3599.9820000899826;663.9568428052161;664.5414663881907;667.7863083813133;669.3172963577124;679.6160169504215;657.1128975882616;691.3190507350256;718.4647437658978;751.1849643137148;781.8944442500303;8757.737267881974;9492.917509820303;9497.097775711296;9624.989376115547;9640.71077867665;715.2454160860239;777.4480119115378;790.8615992201456;800.4196957205979;814.5275740070745;4383.649308055348;4403.4950262324965;4468.50846406895;4500.077484115814;4513.074819661962;69139;72537.6373118131;73746.63126684332;74382.25617743861;74395.25604743992;61679.38320616826;61782.073268901004;61983.38016619776;62360;62902;48137.518624814;55952.44047559554;56957.715211423674;56986.145207821915;58094.41905580975;9109.681161159328;9281.62873485053;9501.144896959031;9576.425414475154;9677.612895484102;33165.50251746178;33821.492677610346;35095;36122.63877361298;36433.27133457369;45834;49659.503404966934;49810;49951.500484994685;49987.75006124946;12397.814032789696;12465.252084874937;12550.560730374393;12579.622611321674;12647.304398258184;13854.584362469142;14223.786643200154;14423.78364324515;14644.414223430944;15089.698206036037;12671.30307833078;13176.407061682055;13363.3986470611;13672.248026358247;14030.158190508602;13043.282619455642;13251.86748132545;13314.667133321744;13468.663283417993;13549;13236.960887633879;13433.529826456028;13439.529616463376;13442.193468391928;13558;11046.723831904266;11215.43922803873;11278.887211127783;11296.887031129583;11356.886431135914;10781.568737250736;10929.125669946545;11127.269456229886;11263.155263355446;11354.318740875575 13:54:00 INFO - PROCESS | 32579 | __end_tp_report 13:54:00 INFO - PROCESS | 32579 | __start_cc_report 13:54:00 INFO - PROCESS | 32579 | _x_x_mozilla_cycle_collect,333 13:54:00 INFO - PROCESS | 32579 | __end_cc_report 13:54:00 INFO - PROCESS | 32579 | __startTimestamp1461617640108__endTimestamp 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - PROCESS | 32579 | ------- Summary: start ------- 13:54:00 INFO - PROCESS | 32579 | Number of tests: 6 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - PROCESS | 32579 | [#0] dojo.html Cycles:165 Average:5715.73 Median:5874.74 stddev:635.30 (10.8%) stddev-sans-first:610.07 13:54:00 INFO - PROCESS | 32579 | Values: 3372.5 3465.1 3472.2 3503.7 3506.9 5747.8 5767.1 5804.6 5836.0 5839.9 5704.9 5772.5 5789.7 5824.0 5826.6 5208.5 5279.0 5310.3 5319.8 5329.8 5231.8 5357.2 5412.6 5416.2 5445.3 5206.2 5278.8 5316.9 5406.4 5425.5 5295.2 5322.1 5325.8 5328.9 5337.3 5186.2 5228.1 5240.2 5279.2 5288.8 5442.2 5545.8 5562.0 5566.2 5570.4 6094.1 6123.2 6125.1 6130.0 6161.4 6220.2 6227.4 6252.7 6265.2 6266.2 5685.1 5782.4 5792.8 5798.2 5874.6 6278.2 6291.2 6333.5 6353.1 6354.7 5999.0 6026.7 6068.4 6069.4 6077.0 5984.5 6089.5 6125.2 6140.4 6165.5 6114.3 6116.0 6116.8 6132.3 6150.1 6121.5 6127.8 6132.3 6141.1 6143.1 4526.8 4615.5 4667.4 4684.5 4685.2 4103.6 4118.3 4119.0 4138.3 4158.4 5718.0 5816.1 5821.3 5832.9 5866.1 6039.7 6064.4 6089.0 6150.3 6172.7 5874.6 5874.7 5877.0 5913.4 5951.2 5206.2 5233.4 5237.0 5245.9 5252.0 6178.8 6410.9 6468.8 6480.4 6489.3 6148.2 6177.1 6184.7 6193.3 6193.6 6182.5 6412.0 6420.4 6420.5 6422.8 5988.3 5996.2 6071.8 6099.3 6115.8 6126.9 6151.2 6172.9 6180.2 6199.6 5930.4 5935.8 5998.5 6003.0 6018.8 5882.4 5977.2 6042.0 6060.0 6070.5 5811.0 5818.0 5843.6 5854.3 5859.7 5849.3 5957.3 5996.2 6000.9 6017.3 5784.8 5801.9 5821.3 5838.2 5838.9 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - PROCESS | 32579 | [#1] ext.html Cycles:180 Average:54953.87 Median:40648.09 stddev:102533.82 (252.2%) stddev-sans-first:102740.14 13:54:00 INFO - PROCESS | 32579 | Values: 567.9 658.2 660.7 667.1 683.8 39589.4 41025.4 41122.0 41283.0 41347.0 40704.4 41083.6 41154.8 41391.6 41450.8 8846.2 9006.0 9055.9 9063.3 9068.4 8962.2 9027.2 9068.7 9079.5 9085.1 8925.5 8940.8 8996.1 8998.9 9004.3 9053.9 9079.2 9146.1 9150.2 9183.1 9022.6 9068.4 9084.0 9113.8 9145.8 39863.0 40640.8 40655.4 40688.2 40846.8 3492.5 3662.8 3709.5 3759.9 3791.5 32952.0 33140.0 33611.2 33986.3 33990.3 4501.2 4650.5 4673.9 4680.5 4703.3 330604.0 330930.0 334068.0 335162.0 335181.0 36578.3 65801.0 66751.3 66800.3 66966.3 37407.0 37582.8 37610.6 37720.0 37724.6 14083.4 14276.3 14336.6 14351.9 14366.7 11786.4 11889.3 11895.2 11902.9 11950.2 9050.5 9123.5 9236.3 9251.4 9260.3 3465.5 3577.9 3600.5 3602.0 3623.7 946.7 1007.8 1014.0 1083.6 1094.7 33008.8 33708.5 33801.5 34057.0 34879.5 1175.5 1181.7 1182.7 1253.9 1286.1 17742.3 18085.9 18201.9 18387.4 18513.2 327409.0 340053.0 344505.0 344835.0 530045.0 56386.2 57632.7 57704.0 57716.7 58230.7 1394.6 1432.5 1440.7 1462.7 1480.2 30750.8 31960.5 32142.4 32513.7 32764.3 55170.0 55919.0 55931.4 56019.2 56084.0 437202.0 437298.0 440585.0 440659.0 440976.0 31622.2 31799.5 31950.0 31996.5 32202.5 51641.5 52265.2 53070.2 53438.7 54210.2 43451.8 44817.6 44920.6 45364.5 46126.3 35343.5 38071.8 39236.8 39250.0 43663.3 43071.6 43341.8 44314.0 44373.8 44393.6 36899.0 36998.8 37151.8 37307.0 37988.4 29100.5 29624.4 29687.4 30134.5 30468.8 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - PROCESS | 32579 | [#2] jquery.html Cycles:180 Average:27590.41 Median:1999.68 stddev:74657.13 (3733.5%) stddev-sans-first:74838.60 13:54:00 INFO - PROCESS | 32579 | Values: 376.3 383.7 385.3 385.7 388.1 17487.8 19158.8 19770.2 20056.1 20070.7 15372.3 15794.1 15908.7 15918.0 15981.2 5542.2 5711.1 5719.1 5766.3 5787.7 4045.2 6073.5 6340.1 6349.1 6361.4 5998.3 6312.1 6314.5 6314.7 6319.7 6237.4 6294.3 6325.6 6345.0 6351.0 5349.8 5443.7 5513.2 5541.4 5584.7 10725.5 11278.2 11363.9 22391.4 22522.4 2305.5 2346.2 2362.9 2565.9 2809.9 8548.7 8839.9 9068.1 9093.0 9142.6 2014.6 2038.9 2049.7 2069.0 2119.9 85470.6 87766.6 89317.0 90375.5 90873.5 10231.5 10334.5 10431.6 10469.6 10518.8 14016.4 14057.2 14073.4 14129.9 14167.0 7618.9 7885.3 7968.7 7984.7 8054.9 7560.0 7770.3 7789.8 7794.6 7795.6 3623.1 3952.2 4045.8 4337.3 4375.9 1764.0 1786.2 1831.7 1833.8 1835.9 379.6 384.0 388.3 393.6 952.9 9135.0 9573.2 16973.0 18960.7 19234.8 1033.3 1036.2 1045.6 1063.9 1115.0 9743.2 10192.7 10240.6 10297.5 10299.8 407753.0 411972.0 415621.0 415631.0 564014.0 97196.5 101632.5 104969.0 105323.0 106338.0 1082.4 1121.9 1125.8 1128.6 1148.6 15740.2 15830.1 15884.0 15921.6 16095.3 41097.2 41444.6 41969.6 42374.3 42607.6 60174.7 61224.7 61275.7 62181.7 62944.4 7292.3 7506.7 7604.0 7685.2 7689.5 8773.7 11551.4 12162.3 12455.4 12565.2 11130.6 11181.8 11246.8 11464.5 11542.9 10672.9 10748.4 10757.2 10781.1 10825.0 11301.2 11348.3 11374.5 11397.2 11409.9 7571.5 7645.9 7713.7 7740.0 7956.2 10386.2 10845.5 10912.8 11376.9 11515.4 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - PROCESS | 32579 | [#3] mootools.html Cycles:180 Average:5542.18 Median:4762.40 stddev:3078.05 (64.6%) stddev-sans-first:3071.34 13:54:00 INFO - PROCESS | 32579 | Values: 1452.9 1537.9 1725.8 1841.3 1871.8 7442.5 7909.5 8115.5 8578.0 8593.4 8203.6 8302.1 8312.5 8338.2 8345.9 2264.1 2278.3 2287.9 2292.3 2296.0 2275.5 2290.7 2299.3 2306.7 2317.9 2328.0 2344.5 2346.5 2354.8 2373.6 2271.9 2274.2 2281.8 2284.6 2289.3 2270.7 2277.3 2282.7 2285.6 2288.7 8440.5 8448.2 8491.6 8514.9 8563.8 4755.8 4953.9 4962.1 4972.9 4975.7 3278.0 3334.3 3437.4 3458.0 3486.3 1114.4 1115.7 1126.6 1157.8 1162.9 11307.2 11328.0 11432.9 11458.7 11469.5 4457.5 4495.0 4572.1 4621.6 4639.8 8772.9 8827.2 8834.4 8839.8 8871.6 4741.4 4769.0 4780.9 4784.1 4798.5 4025.0 4329.5 4405.4 4445.6 4455.8 3723.1 3766.5 3846.0 3865.1 3875.2 1145.9 1150.3 1150.4 1151.9 1154.6 925.8 1069.6 1084.7 1101.1 1119.2 5839.4 5891.3 6062.6 6110.4 6239.0 417.6 417.6 419.7 424.6 433.1 4222.0 4265.5 4335.7 4343.5 4371.2 10165.5 10400.5 10556.1 10699.0 10709.7 10156.8 10443.9 10522.7 10569.9 10601.8 7877.5 7880.2 7918.1 7987.5 7998.7 5961.5 6008.7 6057.1 6211.4 6251.5 9188.6 9742.3 9864.9 9881.3 9889.8 9322.3 9390.1 9520.0 9527.1 9600.6 7071.0 7136.4 7395.7 7479.8 7639.9 8115.0 8129.7 8200.1 8245.0 8259.6 6886.4 7036.8 7062.7 7156.4 7162.4 7419.2 7529.3 7563.9 7600.7 7624.5 6389.5 6452.0 6492.8 6507.5 6508.3 5212.5 5215.6 5252.4 5279.8 5360.2 5092.5 5185.7 5196.8 5293.6 5363.7 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - PROCESS | 32579 | [#4] prototype.html Cycles:180 Average:5056.27 Median:5792.01 stddev:1561.39 (27.0%) stddev-sans-first:1524.36 13:54:00 INFO - PROCESS | 32579 | Values: 297.1 305.8 311.0 312.9 314.7 5594.4 5680.6 5720.8 5781.9 5832.2 5704.9 5732.5 5743.9 5757.5 5771.0 4371.3 4371.9 4377.5 4393.3 4394.6 4095.9 4323.6 4325.0 4364.0 4371.5 4227.5 4245.0 4258.9 4263.5 4280.5 4266.5 4278.7 4279.3 4279.5 4293.8 3539.9 3683.7 3712.5 3714.1 3732.8 5472.0 5481.7 5515.9 5519.7 5521.8 4857.4 4867.6 4890.2 4890.3 4914.5 5655.2 5940.5 5941.5 5949.7 5960.3 4027.0 4030.2 4042.6 4050.9 4053.1 6258.6 6262.7 6274.7 6323.5 6351.2 4070.5 4148.6 4155.5 4161.3 4184.6 4194.0 4210.3 4212.7 4222.7 4230.4 4877.8 4895.6 4939.1 4954.6 4966.4 5881.6 6000.5 6033.7 6059.8 6066.6 1495.5 1502.0 1504.4 1506.3 1511.1 979.6 991.7 1000.4 1002.7 1009.4 6293.3 6304.2 6317.4 6322.8 6327.3 6591.4 6608.7 6627.1 6705.1 6709.4 6092.5 6281.3 6306.5 6308.8 6313.8 3556.5 3581.4 3581.6 3587.4 3590.0 6234.3 6469.4 6527.3 6539.2 6944.8 6338.6 6383.3 6416.5 6442.7 6453.8 6324.5 6459.1 6483.2 6515.6 6524.5 6245.3 6245.9 6253.6 6268.2 6322.3 5848.6 6127.3 6131.8 6145.0 6150.7 6190.8 6435.6 6570.1 6596.8 6604.8 4005.3 4065.2 4095.5 4097.2 4118.0 6147.8 6172.2 6178.6 6195.8 6201.0 5751.7 5883.0 5950.8 5972.4 5978.5 5916.7 5936.2 5946.1 5961.8 5972.5 5699.3 5802.2 5805.0 5834.3 5859.1 5725.7 6099.2 6131.4 6152.8 6153.3 5927.2 5928.4 5949.6 5989.6 5997.5 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - PROCESS | 32579 | [#5] yui.html Cycles:180 Average:15941.28 Median:46985.76 stddev:19115.61 (40.7%) stddev-sans-first:19135.50 13:54:00 INFO - PROCESS | 32579 | Values: 817.6 854.1 885.7 914.0 918.0 13876.4 14724.9 15119.5 15187.6 15207.6 13995.4 13999.7 14017.2 14035.6 14097.5 723.6 858.9 881.5 881.6 884.9 885.1 894.4 896.2 896.2 900.4 930.9 934.4 936.7 940.3 941.6 930.1 931.8 933.5 934.9 939.0 685.7 685.9 686.7 689.1 690.5 12001.5 12016.0 12020.6 12061.2 12117.1 14302.0 14383.6 14526.4 14631.4 14701.6 12075.9 12108.0 12187.6 12229.9 12378.8 3996.0 4012.8 4055.9 4075.6 4102.6 56245.0 57612.0 57762.7 59159.7 59621.1 11428.4 11533.4 11665.2 11860.8 12024.8 21237.2 21249.0 21252.9 21349.1 21404.7 8186.5 8225.8 8282.8 8384.3 8627.0 4913.2 4976.4 5034.7 5042.2 5043.0 3456.3 3569.1 3591.2 3595.7 3600.0 664.0 664.5 667.8 669.3 679.6 657.1 691.3 718.5 751.2 781.9 8757.7 9492.9 9497.1 9625.0 9640.7 715.2 777.4 790.9 800.4 814.5 4383.6 4403.5 4468.5 4500.1 4513.1 69139.0 72537.6 73746.6 74382.3 74395.3 61679.4 61782.1 61983.4 62360.0 62902.0 48137.5 55952.4 56957.7 56986.1 58094.4 9109.7 9281.6 9501.1 9576.4 9677.6 33165.5 33821.5 35095.0 36122.6 36433.3 45834.0 49659.5 49810.0 49951.5 49987.8 12397.8 12465.3 12550.6 12579.6 12647.3 13854.6 14223.8 14423.8 14644.4 15089.7 12671.3 13176.4 13363.4 13672.2 14030.2 13043.3 13251.9 13314.7 13468.7 13549.0 13237.0 13433.5 13439.5 13442.2 13558.0 11046.7 11215.4 11278.9 11296.9 11356.9 10781.6 10929.1 11127.3 11263.2 11354.3 13:54:00 INFO - PROCESS | 32579 | -------- Summary: end -------- 13:54:00 INFO - PROCESS | 32579 | 13:54:00 INFO - TEST-INFO | 32579: exit 0 13:54:00 INFO - TEST-OK | dromaeo_css | took 1109115ms 13:54:00 INFO - TEST-START | kraken 13:54:00 INFO - operating with platform_type : linux_ 13:54:00 INFO - Initialising browser for kraken test... 13:54:00 INFO - TEST-INFO | started process 352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4dy1v3/profile http://localhost:37640/getInfo.html) 13:54:04 INFO - PROCESS | 352 | 13:54:04 INFO - PROCESS | 352 | (process:434): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:54:04 INFO - PROCESS | 352 | __metrics Screen width/height:1600/1200 13:54:04 INFO - PROCESS | 352 | colorDepth:24 13:54:04 INFO - PROCESS | 352 | Browser inner width/height: 1024/697 13:54:04 INFO - PROCESS | 352 | __metrics 13:54:05 ERROR - PROCESS | 352 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:54:06 INFO - TEST-INFO | 352: exit 0 13:54:06 INFO - Browser initialized. 13:54:06 INFO - Running cycle 1/1 for kraken test... 13:54:06 INFO - TEST-INFO | started process 485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4dy1v3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:54:07 INFO - PROCESS | 485 | 13:54:07 INFO - PROCESS | 485 | (process:553): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:54:17 INFO - PROCESS | 485 | RSS: Main: 152735744 13:54:17 INFO - PROCESS | 485 | 13:54:20 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37640/tests/kraken/driver.html?testName=audio-beat-detection) 13:54:21 INFO - PROCESS | 485 | RSS: Main: 157249536 13:54:21 INFO - PROCESS | 485 | 13:54:23 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37640/tests/kraken/driver.html?testName=audio-dft) 13:54:24 INFO - PROCESS | 485 | RSS: Main: 157294592 13:54:24 INFO - PROCESS | 485 | 13:54:27 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37640/tests/kraken/driver.html?testName=audio-fft) 13:54:27 INFO - PROCESS | 485 | RSS: Main: 157343744 13:54:27 INFO - PROCESS | 485 | 13:54:30 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37640/tests/kraken/driver.html?testName=audio-oscillator) 13:54:30 INFO - PROCESS | 485 | RSS: Main: 157265920 13:54:30 INFO - PROCESS | 485 | 13:54:32 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37640/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:54:33 INFO - PROCESS | 485 | RSS: Main: 157491200 13:54:33 INFO - PROCESS | 485 | 13:54:36 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37640/tests/kraken/driver.html?testName=imaging-darkroom) 13:54:37 INFO - PROCESS | 485 | RSS: Main: 158134272 13:54:37 INFO - PROCESS | 485 | 13:54:40 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37640/tests/kraken/driver.html?testName=imaging-desaturate) 13:54:41 INFO - PROCESS | 485 | RSS: Main: 158404608 13:54:41 INFO - PROCESS | 485 | 13:54:43 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37640/tests/kraken/driver.html?testName=json-parse-financial) 13:54:44 INFO - PROCESS | 485 | RSS: Main: 157999104 13:54:44 INFO - PROCESS | 485 | 13:54:46 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37640/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:54:46 INFO - PROCESS | 485 | RSS: Main: 157679616 13:54:46 INFO - PROCESS | 485 | 13:54:48 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37640/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:54:49 INFO - PROCESS | 485 | RSS: Main: 157872128 13:54:49 INFO - PROCESS | 485 | 13:54:51 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37640/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:54:51 INFO - PROCESS | 485 | RSS: Main: 158588928 13:54:51 INFO - PROCESS | 485 | 13:54:54 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:54:54 INFO - PROCESS | 485 | RSS: Main: 158453760 13:54:54 INFO - PROCESS | 485 | 13:54:57 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:54:58 INFO - PROCESS | 485 | RSS: Main: 158515200 13:54:58 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | Cycle 1(1): loaded http://localhost:37640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37640/tests/kraken/driver.html?testName=ai-astar) 13:55:00 INFO - PROCESS | 485 | RSS: Main: 160153600 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | __start_tp_report 13:55:00 INFO - PROCESS | 485 | _x_x_mozilla_page_load 13:55:00 INFO - PROCESS | 485 | _x_x_mozilla_page_load_details 13:55:00 INFO - PROCESS | 485 | |i|pagename|runs| 13:55:00 INFO - PROCESS | 485 | |0;ai-astar;111;105;110;112;113;122;112;110;110;110 13:55:00 INFO - PROCESS | 485 | |1;audio-beat-detection;159;125;154;173;125;157;160;125;187;131 13:55:00 INFO - PROCESS | 485 | |2;audio-dft;160;163;169;164;160;161;161;162;163;162 13:55:00 INFO - PROCESS | 485 | |3;audio-fft;75;77;73;176;74;77;73;77;176;77 13:55:00 INFO - PROCESS | 485 | |4;audio-oscillator;92;92;144;91;93;92;149;94;93;143 13:55:00 INFO - PROCESS | 485 | |5;imaging-gaussian-blur;118;118;118;117;118;118;117;117;117;117 13:55:00 INFO - PROCESS | 485 | |6;imaging-darkroom;147;148;147;146;147;147;147;147;147;147 13:55:00 INFO - PROCESS | 485 | |7;imaging-desaturate;95;95;96;95;95;95;94;95;96;96 13:55:00 INFO - PROCESS | 485 | |8;json-parse-financial;65;66;65;64;64;68;70;87;63;62 13:55:00 INFO - PROCESS | 485 | |9;json-stringify-tinderbox;58;57;57;58;58;57;56;63;57;57 13:55:00 INFO - PROCESS | 485 | |10;stanford-crypto-aes;74;77;73;72;73;74;74;75;74;75 13:55:00 INFO - PROCESS | 485 | |11;stanford-crypto-ccm;132;125;128;119;125;130;126;126;166;120 13:55:00 INFO - PROCESS | 485 | |12;stanford-crypto-pbkdf2;160;165;159;162;160;158;161;164;161;159 13:55:00 INFO - PROCESS | 485 | |13;stanford-crypto-sha256-iterative;70;66;70;72;66;67;67;66;68;65 13:55:00 INFO - PROCESS | 485 | __end_tp_report 13:55:00 INFO - PROCESS | 485 | __start_cc_report 13:55:00 INFO - PROCESS | 485 | _x_x_mozilla_cycle_collect,833 13:55:00 INFO - PROCESS | 485 | __end_cc_report 13:55:00 INFO - PROCESS | 485 | __startTimestamp1461617700265__endTimestamp 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | ------- Summary: start ------- 13:55:00 INFO - PROCESS | 485 | Number of tests: 14 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:4.28 (3.8%) stddev-sans-first:4.53 13:55:00 INFO - PROCESS | 485 | Values: 111.0 105.0 110.0 112.0 113.0 122.0 112.0 110.0 110.0 110.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:158.00 stddev:22.06 (14.0%) stddev-sans-first:23.13 13:55:00 INFO - PROCESS | 485 | Values: 159.0 125.0 154.0 173.0 125.0 157.0 160.0 125.0 187.0 131.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.64 (1.6%) stddev-sans-first:2.64 13:55:00 INFO - PROCESS | 485 | Values: 160.0 163.0 169.0 164.0 160.0 161.0 161.0 162.0 163.0 162.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:42.46 (55.9%) stddev-sans-first:44.38 13:55:00 INFO - PROCESS | 485 | Values: 75.0 77.0 73.0 176.0 74.0 77.0 73.0 77.0 176.0 77.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.00 stddev:25.61 (27.8%) stddev-sans-first:26.48 13:55:00 INFO - PROCESS | 485 | Values: 92.0 92.0 144.0 91.0 93.0 92.0 149.0 94.0 93.0 143.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:55:00 INFO - PROCESS | 485 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 13:55:00 INFO - PROCESS | 485 | Values: 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 13:55:00 INFO - PROCESS | 485 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 96.0 96.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:65.50 stddev:7.28 (11.1%) stddev-sans-first:7.66 13:55:00 INFO - PROCESS | 485 | Values: 65.0 66.0 65.0 64.0 64.0 68.0 70.0 87.0 63.0 62.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:57.50 stddev:1.93 (3.4%) stddev-sans-first:2.05 13:55:00 INFO - PROCESS | 485 | Values: 58.0 57.0 57.0 58.0 58.0 57.0 56.0 63.0 57.0 57.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:1.37 (1.9%) stddev-sans-first:1.45 13:55:00 INFO - PROCESS | 485 | Values: 74.0 77.0 73.0 72.0 73.0 74.0 74.0 75.0 74.0 75.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:127.00 stddev:13.36 (10.5%) stddev-sans-first:14.14 13:55:00 INFO - PROCESS | 485 | Values: 132.0 125.0 128.0 119.0 125.0 130.0 126.0 126.0 166.0 120.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:2.23 (1.4%) stddev-sans-first:2.35 13:55:00 INFO - PROCESS | 485 | Values: 160.0 165.0 159.0 162.0 160.0 158.0 161.0 164.0 161.0 159.0 13:55:00 INFO - PROCESS | 485 | 13:55:00 INFO - PROCESS | 485 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:2.26 (3.4%) stddev-sans-first:2.24 13:55:00 INFO - PROCESS | 485 | Values: 70.0 66.0 70.0 72.0 66.0 67.0 67.0 66.0 68.0 65.0 13:55:00 INFO - PROCESS | 485 | -------- Summary: end -------- 13:55:00 INFO - PROCESS | 485 | 13:55:01 INFO - TEST-INFO | 485: exit 0 13:55:01 INFO - TEST-OK | kraken | took 60406ms 13:55:01 INFO - SUITE-END | took 1169s 13:55:01 INFO - Completed test suite (00:19:29) 13:55:01 INFO - javascript benchmark 13:55:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.4941258811177, 3465.1337165708583, 3472.2187507810763, 3503.6846683798453, 3506.9298614027734, 5747.798827041054, 5767.106098554731, 5804.593678442506, 5836.037053886114, 5839.883202335956, 5704.857378565538, 5772.480476757091, 5789.681567513796, 5823.970880145604, 5826.563007774413, 5208.453112423198, 5278.973605131969, 5310.273248038959, 5319.787208511655, 5329.840104796843, 5231.790728370861, 5357.223202635615, 5412.621116521845, 5416.187571864212, 5445.264889239961, 5206.167013277876, 5278.762455689484, 5316.9202461963105, 5406.405295417501, 5425.457454254562, 5295.232191332255, 5322.148456246982, 5325.760340784635, 5328.946710532922, 5337.252784610138, 5186.196139598331, 5228.08508511009, 5240.161574148118, 5279.155335146396, 5288.762005709714, 5442.156465747816, 5545.77816887324, 5562.0, 5566.2207290979295, 5570.442955704438, 6094.116353128816, 6123.201770564369, 6125.143885071339, 6130.019196928514, 6161.4146656067605, 6220.1913751212505, 6227.408396202399, 6252.6561039142825, 6265.248170219603, 6266.185395898549, 5685.090385538294, 5782.421757824184, 5792.7972520961985, 5798.188253644493, 5874.559408044371, 6278.246610406781, 6291.245050593958, 6333.493320534346, 6353.14232578596, 6354.682265886687, 5999.0, 6026.6986650667295, 6068.393160683984, 6069.393060693896, 6077.0, 5984.461398474158, 6089.512838972872, 6125.235451818339, 6140.3552626974415, 6165.506759459233, 6114.293392522066, 6116.031445914963, 6116.774791473579, 6132.324915438597, 6150.10823430609, 6121.462493334886, 6127.803048439805, 6132.294322189902, 6141.148492690724, 6143.139960405547, 4526.751028693454, 4615.492295847454, 4667.369905062773, 4684.461286951976, 4685.156671799041, 4103.630673239363, 4118.258713431611, 4119.032027473541, 4138.255114079434, 4158.397032430341, 5718.0, 5816.12758086282, 5821.301443826768, 5832.8541786454825, 5866.12008198765, 6039.7282122304605, 6064.36324185963, 6089.0, 6150.323464418911, 6172.722227499773, 5874.5887787854435, 5874.73563689635, 5876.970615146897, 5913.379095195029, 5951.226340575698, 5206.193040078794, 5233.4243233244315, 5236.9738151309, 5245.895082098336, 5251.973740131275, 6178.845528861814, 6410.903836442457, 6468.8059358219325, 6480.416762491398, 6489.253735820441, 6148.200733904564, 6177.073438984188, 6184.721687524162, 6193.318734939063, 6193.566450348432, 6182.505399567934, 6412.03819427071, 6420.357964203729, 6420.486361091195, 6422.775202867877, 5988.28140623128, 5996.190514280516, 6071.787487437919, 6099.3290738017895, 6115.755369785159, 6126.853582554517, 6151.15640141876, 6172.8765424690355, 6180.227471566054, 6199.597026193283, 5930.377310382521, 5935.792247271324, 5998.4601385875485, 6003.0, 6018.849528761816, 5882.441168089024, 5977.193078934462, 6042.0, 6060.030964390986, 6070.544709146743, 5811.0, 5818.0, 5843.649381037151, 5854.297484301911, 5859.707014649336, 5849.327327357239, 5957.255343082114, 5996.220491336098, 6000.939990600038, 6017.308009578955, 5784.797532086357, 5801.883962320814, 5821.27234095738, 5838.211841401527, 5838.854028649148], "value": 5674.249634719005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.9403662615425, 658.1575583253434, 660.7092879133182, 667.1493845347181, 683.7777722240273, 39589.4061589076, 41025.38461923073, 41121.971950701285, 41283.0, 41347.0, 40704.38943415844, 41083.58916410835, 41154.794226028826, 41391.58608413915, 41450.792746036306, 8846.24806891415, 9006.0, 9055.909440905605, 9063.274938004977, 9068.410553314046, 8962.193402593797, 9027.232685221765, 9068.682596109138, 9079.455232686027, 9085.13691199335, 8925.509096999695, 8940.776480588005, 8996.145366190201, 8998.86501702475, 9004.324675649319, 9053.909460905405, 9079.18287354138, 9146.131117543822, 9150.176484116428, 9183.08169183083, 9022.593983270703, 9068.410553314014, 9083.954580227057, 9113.81772364549, 9145.771355716093, 39863.0, 40640.796796016126, 40655.39016914749, 40688.186236275105, 40846.79576602128, 3492.4761285807076, 3662.7619204751604, 3709.4621279914263, 3759.8684046058256, 3791.4881490998637, 32952.02287862712, 33140.0, 33611.15972100717, 33986.32027359464, 33990.320193596235, 4501.167284052428, 4650.465196502411, 4673.929891051637, 4680.485146633868, 4703.341532185496, 330604.0, 330930.0, 334068.0, 335161.99999999756, 335181.0, 36578.26843463116, 65801.0, 66751.33248667451, 66800.33199668038, 66966.330336696, 37407.0, 37582.8120859394, 37610.62389376126, 37720.0, 37724.62275377266, 14083.436662533384, 14276.286185690882, 14336.56990290293, 14351.928240358731, 14366.712665746627, 11786.410679465993, 11889.346085965182, 11895.16733828641, 11902.88097119035, 11950.223235489666, 9050.456972581665, 9123.452592844318, 9236.261099112055, 9251.444913305224, 9260.259179265642, 3465.497502862071, 3577.874774382884, 3600.459931010317, 3602.0, 3623.7282203834816, 946.711253067821, 1007.8488226766044, 1013.9910788765226, 1083.550326614462, 1094.698957786615, 33008.83495582555, 33708.49437258443, 33801.49297760487, 34057.0, 34879.4768078479, 1175.4534141624185, 1181.6573193773709, 1182.6629410617932, 1253.9122261441794, 1286.1125823181974, 17742.29030838778, 18085.909570452328, 18201.908990454962, 18387.356442524713, 18513.166907489194, 327409.0, 340053.0, 344505.0, 344835.0, 530045.0, 56386.154207686915, 57632.71183644139, 57704.0, 57716.711416442646, 58230.7088464555, 1394.5607133752835, 1432.5201057645597, 1440.6902515959118, 1462.656275775192, 1480.222882986419, 30750.84624576863, 31960.52059219067, 32142.395594126123, 32513.674863251064, 32764.344713106082, 55170.0, 55919.0, 55931.44068559262, 56019.15971260516, 56084.0, 437202.0, 437298.0, 440585.0, 440659.0, 440976.0, 31622.209444764067, 31799.52300715445, 31950.0, 31996.5200521997, 32202.516962246053, 51641.48358516367, 52265.21602176046, 53070.2039469416, 53438.73280633572, 54210.186847198114, 43451.78274108609, 44817.551824481336, 44920.55079449164, 45364.54635453603, 46126.30810537912, 35343.46984795179, 38071.809640951615, 39236.80381598074, 39250.0, 43663.345049824915, 43071.56928430801, 43341.783291083346, 44314.0, 44373.77813110914, 44393.55606443894, 36899.0, 36998.8150059248, 37151.81424092862, 37307.0, 37988.43017354687, 29100.513250653436, 29624.407511850073, 29687.406251875273, 30134.54798177985, 30468.84765576158], "value": 19266.458973906207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.26252545011795, 383.6566273185498, 385.27568171836947, 385.7299890076945, 388.12671489149415, 17487.825121748778, 19158.80841191591, 19770.209191632337, 20056.097475613577, 20070.698939515918, 15372.308246128923, 15794.131322777243, 15908.681826363494, 15918.0, 15981.200939953014, 5542.224088627595, 5711.114777209539, 5719.14212868069, 5766.250387449626, 5787.710614469281, 4045.2111838191563, 6073.453389194971, 6340.112384266206, 6349.079383489415, 6361.3638636136475, 5998.310194327664, 6312.053192021211, 6314.526410519206, 6314.6842657867155, 6319.74721011159, 6237.438630523252, 6294.307626161119, 6325.588836725598, 6344.968275158618, 6351.047342898579, 5349.786008559653, 5443.673379597237, 5513.173024046385, 5541.445855414427, 5584.664920104807, 10725.463726813628, 11278.15413843965, 11363.886361136365, 22391.440213994618, 22522.436939076655, 2305.5158416732506, 2346.1905642553293, 2362.881855907198, 2565.948681026369, 2809.929751756202, 8548.658053677907, 8839.867401988975, 9068.093190680946, 9092.954535227347, 9142.634294628207, 2014.63736527425, 2038.9184432622826, 2049.723287356203, 2068.958620827575, 2119.9152033918626, 85470.57264713699, 87766.56116719439, 89317.0, 90375.54812225963, 90873.54563227207, 10231.488425578691, 10334.483275836328, 10431.634892778717, 10469.581216751398, 10518.842217366746, 14016.369263383172, 14057.226852523005, 14073.366698498592, 14129.929350353388, 14167.0, 7618.923810761932, 7885.250901164381, 7968.721094761656, 7984.6806127754235, 8054.879176812353, 7560.0, 7770.339521140766, 7789.805254868674, 7794.610269486503, 7795.649195786204, 3623.0942264433893, 3952.2095580883365, 4045.838166473367, 4337.284348082531, 4375.868723938287, 1763.982360176382, 1786.1872847854195, 1831.716084006981, 1833.8166183381823, 1835.8898466092078, 379.6374462388412, 384.0456465682776, 388.25455126157283, 393.5828022296375, 952.9332946693803, 9134.954325228464, 9573.18627916635, 16973.0, 18960.715589266172, 19234.80765192358, 1033.3489901362243, 1036.212478516318, 1045.6235755128148, 1063.8563793887727, 1115.041064684371, 9743.220542356594, 10192.694219173436, 10240.590376385011, 10297.485125743682, 10299.794004119876, 407753.0, 411972.0, 415621.0, 415631.0, 564014.0, 97196.51401742946, 101632.49183754182, 104969.0, 105323.0, 106338.0, 1082.410086502858, 1121.9382933938712, 1125.8198688210011, 1128.5880653561392, 1148.6094727792424, 15740.212989350715, 15830.050196988217, 15884.0, 15921.601959951095, 16095.275712593195, 41097.178056439305, 41444.585554144076, 41969.631843581636, 42374.305027798546, 42607.57392426036, 60174.699126504085, 61224.693876530335, 61275.69362153161, 62181.68909155425, 62944.37055629385, 7292.270772922665, 7506.662200201114, 7604.0, 7685.193054729397, 7689.538627682357, 8773.692920747742, 11551.364674942959, 12162.270263784201, 12455.439505222106, 12565.18326308787, 11130.554777808797, 11181.776364472827, 11246.83129753038, 11464.541418343173, 11542.94228528852, 10672.946635266773, 10748.408837514013, 10757.246992710749, 10781.137508999105, 10825.025747682746, 11301.208915375844, 11348.262362946381, 11374.545018199511, 11397.202195846543, 11409.885901140882, 7571.507851989603, 7645.923540764521, 7713.691452341844, 7740.032495938008, 7956.189089168046, 10386.221033422373, 10845.511951962339, 10912.781744365227, 11376.94311528437, 11515.36665483373], "value": 8677.109609150164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.9128252304859, 1537.8769698424128, 1725.8015328237257, 1841.300305883764, 1871.7847447543536, 7442.516236444627, 7909.485883417574, 8115.513069215844, 8578.0, 8593.398462107654, 8203.589820508965, 8302.086770455246, 8312.459690120138, 8338.166183381658, 8345.874811877811, 2264.105678257083, 2278.3278932714807, 2287.8512896661746, 2292.323764489471, 2295.9655605165935, 2275.544891021794, 2290.725112986444, 2299.3446867642724, 2306.723193216808, 2317.884105794712, 2327.976720232801, 2344.5193735284224, 2346.495503466754, 2354.8233882458885, 2373.560891235127, 2271.8636881787147, 2274.215395688493, 2281.760415156418, 2284.6001949658744, 2289.3132060381818, 2270.693456383384, 2277.271273192579, 2282.691836602054, 2285.6000199965106, 2288.702468679078, 8440.451370660887, 8448.155184481564, 8491.61787719554, 8514.914850851474, 8563.828723425559, 4755.809767609291, 4953.876153096166, 4962.106820772259, 4972.925406118911, 4975.651704380659, 3277.9836100819343, 3334.3498017886523, 3437.415639341318, 3457.9654203457894, 3486.250456151914, 1114.359243435028, 1115.670877091252, 1126.555010770749, 1157.8263260510907, 1162.8546431696038, 11307.208495405324, 11328.0, 11432.885671143265, 11458.713532161595, 11469.541218351256, 4457.465104187519, 4494.988627558773, 4572.1312950539295, 4621.60716339115, 4639.791209395586, 8772.912270877338, 8827.16141966512, 8834.381593288408, 8839.779005524784, 8871.556422178865, 4741.407324084489, 4769.0, 4780.880477988008, 4784.091022705675, 4798.47216806151, 4025.0, 4329.523752387235, 4405.449318835145, 4445.555444455528, 4455.821767129279, 3723.1436769543157, 3766.472693822867, 3845.9807700961314, 3865.072382628205, 3875.244327356195, 1145.8854114588476, 1150.3040660400504, 1150.4362862197631, 1151.9366434846163, 1154.5554961339776, 925.796324808541, 1069.6042464288107, 1084.734240111162, 1101.0750969185763, 1119.216548416112, 5839.357670656224, 5891.3224979127945, 6062.560784391627, 6110.358412366726, 6239.032949892774, 417.62205204290166, 417.6387424877459, 419.6810424077662, 424.5584592024322, 433.09915376017807, 4222.0, 4265.466816647919, 4335.739855608674, 4343.457067866517, 4371.213181627338, 10165.4917254137, 10400.47997600117, 10556.102731267774, 10699.0, 10709.678709638723, 10156.847647285296, 10443.895561044292, 10522.684319470429, 10569.947150264354, 10601.787964240671, 7877.487963282369, 7880.211978802074, 7918.129005809241, 7987.480813747088, 7998.680052797939, 5961.463468287875, 6008.699565021644, 6057.061155520725, 6211.409916057967, 6251.531135164972, 9188.632454702005, 9742.269329800434, 9864.901350986398, 9881.258905582254, 9889.802203956024, 9322.347435679709, 9390.060993900828, 9520.0479952007, 9527.09492598202, 9600.615975360908, 7070.964645176947, 7136.4290856730295, 7395.7041718330665, 7479.813004674709, 7639.923600763921, 8115.0, 8129.715459958873, 8200.138985406686, 8244.958775206085, 8259.587020649064, 6886.414654754201, 7036.824079397851, 7062.682179302046, 7156.355927966508, 7162.427005839624, 7419.183889772013, 7529.322360987538, 7563.886541701989, 7600.650206047553, 7624.466287359832, 6389.48884089281, 6452.032195170762, 6492.766374388851, 6507.544471886922, 6508.316626754312, 5212.488856350274, 5215.634905556726, 5252.400678306584, 5279.788808447619, 5360.249565060816, 5092.541671249605, 5185.662931909414, 5196.841742535108, 5293.576513878804, 5363.704996225245], "value": 4411.022317781571, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.0938637156673, 305.8058133085491, 311.0109850674853, 312.935848151129, 314.7246159610341, 5594.412586678402, 5680.573956953224, 5720.828375148747, 5781.855453613656, 5832.154337621042, 5704.857378565538, 5732.541396688265, 5743.913841292384, 5757.481826635602, 5770.971145144279, 4371.300591905296, 4371.912561748763, 4377.496587892401, 4393.2970724684055, 4394.582514661102, 4095.856645017425, 4323.610875021247, 4325.048489332342, 4363.978180109095, 4371.519132895379, 4227.534971153171, 4245.023644561753, 4258.850940217093, 4263.467066616673, 4280.507741609724, 4266.488021437432, 4278.7218830776055, 4279.251131052085, 4279.529251782302, 4293.785310734482, 3539.911502212465, 3683.723720720957, 3712.535933008374, 3714.0900479382453, 3732.794696291703, 5472.0, 5481.671099734029, 5515.944840551583, 5519.724013799294, 5521.834344969617, 4857.417109946794, 4867.612730371862, 4890.217565189588, 4890.31284206948, 4914.459409464956, 5655.179998900177, 5940.465358117747, 5941.465268125846, 5949.702514874239, 5960.254968128984, 4026.979865100685, 4030.1536677297804, 4042.6159514846045, 4050.9189816203807, 4053.0677944073027, 6258.624482531062, 6262.718177682015, 6274.749010039593, 6323.462505687022, 6351.2060992375955, 4070.4911886014247, 4148.605882441163, 4155.480564929384, 4161.2509748245, 4184.644305234028, 4194.0, 4210.2842516772225, 4212.726172798758, 4222.746635201897, 4230.407742915994, 4877.780499877514, 4895.559399654048, 4939.110960027229, 4954.563176678723, 4966.428860681068, 5881.617694849907, 6000.519958403317, 6033.698315084228, 6059.757609695563, 6066.605670631395, 1495.461633811827, 1501.9561404823762, 1504.368165370547, 1506.314626844805, 1511.146202395665, 979.6326377608397, 991.7371896447447, 1000.3597697473623, 1002.6691191906654, 1009.3799451879628, 6293.276273228637, 6304.211973503312, 6317.399847014526, 6322.778702745474, 6327.335629758901, 6591.373819487141, 6608.735650574019, 6627.138471998609, 6705.1283333166375, 6709.362610552087, 6092.482139018144, 6281.340459251713, 6306.49548036156, 6308.842278943063, 6313.810585682437, 3556.484309775068, 3581.3732596795458, 3581.6239294874185, 3587.4260118380935, 3590.0254859827514, 6234.314225435199, 6469.385408386196, 6527.34726527353, 6539.215294164731, 6944.756933507303, 6338.58799178052, 6383.329750376143, 6416.486681065504, 6442.7436649852825, 6453.806385808433, 6324.494040476751, 6459.089932711517, 6483.157189565326, 6515.641639709766, 6524.510661700391, 6245.28179259391, 6245.8750824982335, 6253.562250642593, 6268.247810262797, 6322.2729386119345, 5848.56135789826, 6127.264728232641, 6131.816045518642, 6145.019665462337, 6150.661713605795, 6190.81427557174, 6435.613863168225, 6570.145881035435, 6596.80209593713, 6604.768833090819, 4005.259027079883, 4065.1666408385618, 4095.5290141634096, 4097.160082183085, 4117.958820411877, 6147.784827531015, 6172.166757487861, 6178.567500274938, 6195.845103872439, 6200.968995154995, 5751.712414379348, 5883.0, 5950.761969521343, 5972.402759723993, 5978.491828194652, 5916.73374698131, 5936.22829032223, 5946.137810017437, 5961.791337303173, 5972.522198224218, 5699.34457537372, 5802.158686990447, 5804.970975145097, 5834.329052159056, 5859.091840764689, 5725.713714314351, 6099.207103076572, 6131.356207598138, 6152.846178845564, 6153.323134455296, 5927.199828023162, 5928.436798504135, 5949.553783466171, 5989.550783691154, 5997.490213331916], "value": 4543.930599337328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.619806789843, 854.1373213054817, 885.6501681835675, 913.9908600913989, 918.0177210384886, 13876.444942202312, 14724.852751472483, 15119.546413607583, 15187.633113019827, 15207.619809504768, 13995.440182392693, 13999.720005599882, 14017.15897046178, 14035.649108772286, 14097.506587269447, 723.5622448418696, 858.8539948208788, 881.497546398553, 881.5900606218107, 884.8893888263967, 885.0662551008684, 894.4365050018479, 896.1665650944619, 896.1665650944619, 900.4012331799378, 930.8836395450569, 934.3552948465536, 936.7236665183788, 940.2947789158131, 941.6139382853031, 930.1303281431815, 931.8136372725414, 933.5099072986668, 934.9345545811796, 939.0327962198912, 685.6571714142929, 685.8868286732733, 686.6978529447077, 689.0869597782957, 690.4752388185016, 12001.459934302977, 12016.0, 12020.63938081859, 12061.155719099666, 12117.091218158585, 14302.0, 14383.568492945229, 14526.418943242257, 14631.41474341025, 14701.632459188499, 12075.939620301842, 12108.0, 12187.573434929735, 12229.93885030578, 12378.75242495154, 3995.960040399588, 4012.779297138656, 4055.8986025349604, 4075.572064933169, 4102.630763231294, 56245.0, 57612.0, 57762.71118644422, 59159.704201479144, 59621.10568341478, 11428.428578571038, 11533.423328833525, 11665.183437159318, 11860.762784744256, 12024.819627705592, 21237.150513979577, 21249.0, 21252.893735531223, 21349.14603415846, 21404.678929816066, 8186.549739764251, 8225.753227403187, 8282.792930176794, 8384.287335576544, 8626.956865215634, 4913.238448040559, 4976.353074100344, 5034.697918124924, 5042.243663450512, 5042.974785126051, 3456.2914602506426, 3569.089882080053, 3591.174029973121, 3595.748297619194, 3599.9820000899826, 663.9568428052161, 664.5414663881907, 667.7863083813133, 669.3172963577124, 679.6160169504215, 657.1128975882616, 691.3190507350256, 718.4647437658978, 751.1849643137148, 781.8944442500303, 8757.737267881974, 9492.917509820303, 9497.097775711296, 9624.989376115547, 9640.71077867665, 715.2454160860239, 777.4480119115378, 790.8615992201456, 800.4196957205979, 814.5275740070745, 4383.649308055348, 4403.4950262324965, 4468.50846406895, 4500.077484115814, 4513.074819661962, 69139.0, 72537.6373118131, 73746.63126684332, 74382.25617743861, 74395.25604743992, 61679.38320616826, 61782.073268901004, 61983.38016619776, 62360.0, 62902.0, 48137.518624814, 55952.44047559554, 56957.715211423674, 56986.145207821915, 58094.41905580975, 9109.681161159328, 9281.62873485053, 9501.144896959031, 9576.425414475154, 9677.612895484102, 33165.50251746178, 33821.492677610346, 35095.0, 36122.63877361298, 36433.27133457369, 45834.0, 49659.503404966934, 49810.0, 49951.500484994685, 49987.75006124946, 12397.814032789696, 12465.252084874937, 12550.560730374393, 12579.622611321674, 12647.304398258184, 13854.584362469142, 14223.786643200154, 14423.78364324515, 14644.414223430944, 15089.698206036037, 12671.30307833078, 13176.407061682055, 13363.3986470611, 13672.248026358247, 14030.158190508602, 13043.282619455642, 13251.86748132545, 13314.667133321744, 13468.663283417993, 13549.0, 13236.960887633879, 13433.529826456028, 13439.529616463376, 13442.193468391928, 13558.0, 11046.723831904266, 11215.43922803873, 11278.887211127783, 11296.887031129583, 11356.886431135914, 10781.568737250736, 10929.125669946545, 11127.269456229886, 11263.155263355446, 11354.318740875575], "value": 7137.336048771817, "unit": "score"}], "name": "dromaeo_css", "value": 7168.6740963018965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 112.0, 113.0, 122.0, 112.0, 110.0, 110.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 154.0, 173.0, 125.0, 157.0, 160.0, 125.0, 187.0, 131.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 169.0, 164.0, 160.0, 161.0, 161.0, 162.0, 163.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 73.0, 176.0, 74.0, 77.0, 73.0, 77.0, 176.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 144.0, 91.0, 93.0, 92.0, 149.0, 94.0, 93.0, 143.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 64.0, 68.0, 70.0, 87.0, 63.0, 62.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 58.0, 58.0, 57.0, 56.0, 63.0, 57.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 73.0, 72.0, 73.0, 74.0, 74.0, 75.0, 74.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 128.0, 119.0, 125.0, 130.0, 126.0, 126.0, 166.0, 120.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 159.0, 162.0, 160.0, 158.0, 161.0, 164.0, 161.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 70.0, 72.0, 66.0, 67.0, 67.0, 66.0, 68.0, 65.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1544.7, "alertThreshold": 2.0}]} 13:55:01 INFO - Return code: 0 13:55:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:55:01 ERROR - # TBPL SUCCESS # 13:55:01 INFO - Running post-action listener: _resource_record_post_action 13:55:01 INFO - Running post-run listener: _resource_record_post_run 13:55:02 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 501104640; Read time: 16; Write time: 324384 13:55:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248348672; Read time: 0; Write time: 211640 13:55:02 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252157952; Read time: 16; Write time: 112744 13:55:02 INFO - Running post-run listener: _upload_blobber_files 13:55:02 INFO - Blob upload gear active. 13:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:55:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:55:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:04 INFO - (blobuploader) - INFO - Done attempting. 13:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:05 INFO - (blobuploader) - INFO - Done attempting. 13:55:05 INFO - (blobuploader) - INFO - Iteration through files over. 13:55:05 INFO - Return code: 0 13:55:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:55:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:55:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddc86e486fc7c907faa50df64a871a4f6e69871b721a4d03deabeb8e748804f187d682144032be88e1c82da3fe8fd5a79c84dfc364825f72d1a7c26298c5fd5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb0efed9a394028516339dcf72078bfa6dac90919cbe4d8ead1d8cae2f9fa7b28024e7553df7d9ce21bc346621ac9cb1250b4c16881f2da6f51ca0b8773c398a"} 13:55:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:55:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:55:05 INFO - Contents: 13:55:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddc86e486fc7c907faa50df64a871a4f6e69871b721a4d03deabeb8e748804f187d682144032be88e1c82da3fe8fd5a79c84dfc364825f72d1a7c26298c5fd5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb0efed9a394028516339dcf72078bfa6dac90919cbe4d8ead1d8cae2f9fa7b28024e7553df7d9ce21bc346621ac9cb1250b4c16881f2da6f51ca0b8773c398a"} 13:55:05 INFO - Running post-run listener: copy_logs_to_upload_dir 13:55:05 INFO - Copying logs to upload dir... 13:55:05 INFO - mkdir: /builds/slave/test/build/upload/logs 13:55:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.955023 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-25 13:55:04.835967) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:55:04.839182) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161 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/Mozilla-Aurora/sha512/ddc86e486fc7c907faa50df64a871a4f6e69871b721a4d03deabeb8e748804f187d682144032be88e1c82da3fe8fd5a79c84dfc364825f72d1a7c26298c5fd5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb0efed9a394028516339dcf72078bfa6dac90919cbe4d8ead1d8cae2f9fa7b28024e7553df7d9ce21bc346621ac9cb1250b4c16881f2da6f51ca0b8773c398a"} build_url:https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddc86e486fc7c907faa50df64a871a4f6e69871b721a4d03deabeb8e748804f187d682144032be88e1c82da3fe8fd5a79c84dfc364825f72d1a7c26298c5fd5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb0efed9a394028516339dcf72078bfa6dac90919cbe4d8ead1d8cae2f9fa7b28024e7553df7d9ce21bc346621ac9cb1250b4c16881f2da6f51ca0b8773c398a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:55:04.863671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:55:04.863988) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461616476.585592-1412228161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:55:04.947442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:55:04.947769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:55:04.948063) ========= ========= Total master_lag: 0.16 =========