builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1461222292.35 results: success (0) buildid: 20160420213010 builduid: 98b108a68777428c958cd52d13f6b17f revision: d9fdbad8f079c7801abdef70df2cad93efcce797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.345494) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.345866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.346168) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.369065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.369332) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 00:04:53-- 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% 38.1M=0s 2016-04-21 00:04:53 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120141 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.502260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.502548) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019888 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.558228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:52.558574) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9fdbad8f079c7801abdef70df2cad93efcce797 --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 d9fdbad8f079c7801abdef70df2cad93efcce797 --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=a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 00:04:53,555 truncating revision to first 12 chars 2016-04-21 00:04:53,555 Setting DEBUG logging. 2016-04-21 00:04:53,555 attempt 1/10 2016-04-21 00:04:53,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9fdbad8f079?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 00:04:53,828 unpacking tar archive at: mozilla-aurora-d9fdbad8f079/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543357 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:53.115638) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:53.116036) ========= script_repo_revision: d9fdbad8f079c7801abdef70df2cad93efcce797 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:53.116446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:53.116711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 00:04:53.125401) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-21 00:04:53.125794) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:04:54 INFO - MultiFileLogger online at 20160421 00:04:54 in /builds/slave/test 00:04:54 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 00:04:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:04:54 INFO - {'append_to_log': False, 00:04:54 INFO - 'base_work_dir': '/builds/slave/test', 00:04:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:04:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:04:54 INFO - 'branch': 'Mozilla-Aurora', 00:04:54 INFO - 'buildbot_json_path': 'buildprops.json', 00:04:54 INFO - 'config_files': ('talos/linux_config.py',), 00:04:54 INFO - 'default_actions': ('clobber', 00:04:54 INFO - 'read-buildbot-config', 00:04:54 INFO - 'download-and-extract', 00:04:54 INFO - 'populate-webroot', 00:04:54 INFO - 'create-virtualenv', 00:04:54 INFO - 'install', 00:04:54 INFO - 'run-tests'), 00:04:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:04:54 INFO - 'download_minidump_stackwalk': True, 00:04:54 INFO - 'download_symbols': 'ondemand', 00:04:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:04:54 INFO - 'tooltool.py': '/tools/tooltool.py', 00:04:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:04:54 INFO - '/tools/misc-python/virtualenv.py')}, 00:04:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:04:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:04:54 INFO - 'installer_path': 'installer.exe', 00:04:54 INFO - 'log_level': 'info', 00:04:54 INFO - 'log_name': 'talos', 00:04:54 INFO - 'log_to_console': True, 00:04:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:04:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:04:54 INFO - 'opt_config_files': (), 00:04:54 INFO - 'pip_index': False, 00:04:54 INFO - 'sps_profile': False, 00:04:54 INFO - 'sps_profile_interval': 0, 00:04:54 INFO - 'suite': 'dromaeojs-e10s', 00:04:54 INFO - 'system_bits': '32', 00:04:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:04:54 INFO - 'title': 'talos-linux64-ix-062', 00:04:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:04:54 INFO - 'use_talos_json': True, 00:04:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:04:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:04:54 INFO - 'work_dir': 'build'} 00:04:54 INFO - ##### 00:04:54 INFO - ##### Running clobber step. 00:04:54 INFO - ##### 00:04:54 INFO - Running pre-action listener: _resource_record_pre_action 00:04:54 INFO - Running main action method: clobber 00:04:54 INFO - rmtree: /builds/slave/test/build 00:04:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:04:55 INFO - Running post-action listener: _resource_record_post_action 00:04:55 INFO - ##### 00:04:55 INFO - ##### Running read-buildbot-config step. 00:04:55 INFO - ##### 00:04:55 INFO - Running pre-action listener: _resource_record_pre_action 00:04:55 INFO - Running main action method: read_buildbot_config 00:04:55 INFO - Using buildbot properties: 00:04:55 INFO - { 00:04:55 INFO - "project": "", 00:04:55 INFO - "product": "firefox", 00:04:55 INFO - "script_repo_revision": "production", 00:04:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 00:04:55 INFO - "repository": "", 00:04:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 00:04:55 INFO - "buildid": "20160420213010", 00:04:55 INFO - "pgo_build": "True", 00:04:55 INFO - "basedir": "/builds/slave/test", 00:04:55 INFO - "buildnumber": 246, 00:04:55 INFO - "slavename": "talos-linux64-ix-062", 00:04:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:04:55 INFO - "platform": "ubuntu64_hw", 00:04:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:04:55 INFO - "branch": "mozilla-aurora", 00:04:55 INFO - "repo_path": "releases/mozilla-aurora", 00:04:55 INFO - "revision": "d9fdbad8f079c7801abdef70df2cad93efcce797", 00:04:55 INFO - "stage_platform": "linux64-pgo", 00:04:55 INFO - "builduid": "98b108a68777428c958cd52d13f6b17f", 00:04:55 INFO - "slavebuilddir": "test" 00:04:55 INFO - } 00:04:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 00:04:55 INFO - Running post-action listener: _resource_record_post_action 00:04:55 INFO - ##### 00:04:55 INFO - ##### Running download-and-extract step. 00:04:55 INFO - ##### 00:04:55 INFO - Running pre-action listener: _resource_record_pre_action 00:04:55 INFO - Running main action method: download_and_extract 00:04:55 INFO - mkdir: /builds/slave/test/build/tests 00:04: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')]} 00:04:55 INFO - https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:04:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 00:04:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 00:04:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 00:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:05:05 INFO - Downloaded 1448 bytes. 00:05:05 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 00:05:05 INFO - Using the following test package requirements: 00:05:05 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 00:05:05 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:05:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:05:05 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:05:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:05:05 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:05:05 INFO - u'jsshell-linux-x86_64.zip'], 00:05:05 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:05:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:05:05 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 00:05:05 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:05:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:05:05 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:05:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:05:05 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:05:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:05:05 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 00:05:05 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 00:05:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:05:05 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:05 INFO - https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:05:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:05:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:05:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:05:18 INFO - Downloaded 23354912 bytes. 00:05:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:05:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:05:19 INFO - Return code: 0 00:05:19 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:05:19 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')]} 00:05:19 INFO - https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:05:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:05:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:05:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 00:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:05:21 INFO - Downloaded 23354912 bytes. 00:05:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:05:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:05:22 INFO - Return code: 0 00:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:22 INFO - https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:05:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 00:05:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 00:05:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 00:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:05:23 INFO - Downloaded 10845198 bytes. 00:05:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:05:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:05:23 INFO - Return code: 0 00:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:23 INFO - https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:05:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:05:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:05:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:05:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:05:25 INFO - Downloaded 60615152 bytes. 00:05:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:05:25 INFO - mkdir: /builds/slave/test/properties 00:05:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:05:25 INFO - Writing to file /builds/slave/test/properties/build_url 00:05:25 INFO - Contents: 00:05:25 INFO - build_url:https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 00:05:25 INFO - Running post-action listener: _resource_record_post_action 00:05:25 INFO - Running post-action listener: set_extra_try_arguments 00:05:25 INFO - ##### 00:05:25 INFO - ##### Running populate-webroot step. 00:05:25 INFO - ##### 00:05:25 INFO - Running pre-action listener: _resource_record_pre_action 00:05:25 INFO - Running main action method: populate_webroot 00:05:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:05:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:05:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:05:25 INFO - '--tppagecycles', 00:05:25 INFO - '7'], 00:05:25 INFO - 'tests': ['tsvgm']}}, 00:05:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:05:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:05:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 00:05:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:05:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:25 INFO - 'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:25 INFO - 'tests': ['damp', 'tps']}, 00:05:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:25 INFO - 'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['damp', 'tps']}, 00:05:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:05:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:05:25 INFO - 'other': {'tests': ['a11yr', 00:05:25 INFO - 'ts_paint', 00:05:25 INFO - 'tpaint', 00:05:25 INFO - 'sessionrestore', 00:05:25 INFO - 'sessionrestore_no_auto_restore', 00:05:25 INFO - 'tabpaint']}, 00:05:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['a11yr', 00:05:25 INFO - 'ts_paint', 00:05:25 INFO - 'tpaint', 00:05:25 INFO - 'sessionrestore', 00:05:25 INFO - 'sessionrestore_no_auto_restore', 00:05:25 INFO - 'tabpaint']}, 00:05:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['a11yr', 00:05:25 INFO - 'ts_paint', 00:05:25 INFO - 'tpaint', 00:05:25 INFO - 'sessionrestore', 00:05:25 INFO - 'sessionrestore_no_auto_restore', 00:05:25 INFO - 'tabpaint']}, 00:05:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['a11yr', 00:05:25 INFO - 'ts_paint', 00:05:25 INFO - 'tpaint', 00:05:25 INFO - 'sessionrestore', 00:05:25 INFO - 'sessionrestore_no_auto_restore', 00:05:25 INFO - 'tabpaint']}, 00:05:25 INFO - 'other_l64': {'tests': ['a11yr', 00:05:25 INFO - 'ts_paint', 00:05:25 INFO - 'tpaint', 00:05:25 INFO - 'sessionrestore', 00:05:25 INFO - 'sessionrestore_no_auto_restore', 00:05:25 INFO - 'tabpaint']}, 00:05:25 INFO - 'other_nol64': {'tests': ['a11yr', 00:05:25 INFO - 'ts_paint', 00:05:25 INFO - 'tpaint', 00:05:25 INFO - 'sessionrestore', 00:05:25 INFO - 'sessionrestore_no_auto_restore', 00:05:25 INFO - 'tabpaint']}, 00:05:25 INFO - 'svgr': {'tests': ['tsvgx', 00:05:25 INFO - 'tsvgr_opacity', 00:05:25 INFO - 'tart', 00:05:25 INFO - 'tscrollx', 00:05:25 INFO - 'cart']}, 00:05:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['tsvgx', 00:05:25 INFO - 'tsvgr_opacity', 00:05:25 INFO - 'tart', 00:05:25 INFO - 'tscrollx', 00:05:25 INFO - 'cart']}, 00:05:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:25 INFO - 'tests': ['tp5o']}, 00:05:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:25 INFO - 'talos_options': ['--e10s'], 00:05:25 INFO - 'tests': ['tp5o']}, 00:05:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:25 INFO - 'talos_options': ['--xperf_path', 00:05:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:25 INFO - 'tests': ['tp5n']}, 00:05:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:25 INFO - 'talos_options': ['--e10s', 00:05:25 INFO - '--xperf_path', 00:05:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:25 INFO - 'tests': ['tp5n']}}, 00:05:25 INFO - 'talos.zip': {'path': '', 00:05:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:05:25 INFO - Running post-action listener: _resource_record_post_action 00:05:25 INFO - ##### 00:05:25 INFO - ##### Running create-virtualenv step. 00:05:25 INFO - ##### 00:05:25 INFO - Running pre-action listener: _resource_record_pre_action 00:05:25 INFO - Running main action method: create_virtualenv 00:05:25 INFO - Creating virtualenv /builds/slave/test/build/venv 00:05:25 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 00:05:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:05:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:05:25 INFO - Using real prefix '/usr' 00:05:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:05:26 INFO - Installing distribute.............................................................................................................................................................................................done. 00:05:28 INFO - Installing pip.................done. 00:05:28 INFO - Return code: 0 00:05:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:05:28 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')]} 00:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:28 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')]} 00:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:28 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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:28 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 00:05:28 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 00:05:28 INFO - Using env: {'DISPLAY': ':0', 00:05:28 INFO - 'HOME': '/home/cltbld', 00:05:28 INFO - 'LANG': 'en_US.UTF-8', 00:05:28 INFO - 'LANGUAGE': 'en_US:en', 00:05:28 INFO - 'LOGNAME': 'cltbld', 00:05:28 INFO - 'MAIL': '/var/mail/cltbld', 00:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:28 INFO - 'MOZ_NO_REMOTE': '1', 00:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:28 INFO - 'NO_EM_RESTART': '1', 00:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:28 INFO - 'PWD': '/builds/slave/test', 00:05:28 INFO - 'SHELL': '/bin/bash', 00:05:28 INFO - 'SHLVL': '1', 00:05:28 INFO - 'TERM': 'linux', 00:05:28 INFO - 'TMOUT': '86400', 00:05:28 INFO - 'USER': 'cltbld', 00:05:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:28 INFO - '_': '/tools/buildbot/bin/python'} 00:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:28 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 00:05:28 INFO - Cleaning up... 00:05:28 INFO - Return code: 0 00:05:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:05:28 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')]} 00:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:28 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')]} 00:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:28 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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:28 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 00:05:28 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 00:05:28 INFO - Using env: {'DISPLAY': ':0', 00:05:28 INFO - 'HOME': '/home/cltbld', 00:05:28 INFO - 'LANG': 'en_US.UTF-8', 00:05:28 INFO - 'LANGUAGE': 'en_US:en', 00:05:28 INFO - 'LOGNAME': 'cltbld', 00:05:28 INFO - 'MAIL': '/var/mail/cltbld', 00:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:28 INFO - 'MOZ_NO_REMOTE': '1', 00:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:28 INFO - 'NO_EM_RESTART': '1', 00:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:28 INFO - 'PWD': '/builds/slave/test', 00:05:28 INFO - 'SHELL': '/bin/bash', 00:05:28 INFO - 'SHLVL': '1', 00:05:28 INFO - 'TERM': 'linux', 00:05:28 INFO - 'TMOUT': '86400', 00:05:28 INFO - 'USER': 'cltbld', 00:05:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:28 INFO - '_': '/tools/buildbot/bin/python'} 00:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:28 INFO - Downloading/unpacking psutil>=0.7.1 00:05:28 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 00:05:28 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 00:05:28 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 00:05:28 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 00:05:28 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 00:05:28 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 00:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:05:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:30 INFO - Installing collected packages: psutil 00:05:30 INFO - Running setup.py install for psutil 00:05:30 INFO - building 'psutil._psutil_linux' extension 00:05:30 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 00:05:31 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 00:05:31 INFO - building 'psutil._psutil_posix' extension 00:05:31 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 00:05:31 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 00:05:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:31 INFO - Successfully installed psutil 00:05:31 INFO - Cleaning up... 00:05:31 INFO - Return code: 0 00:05:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:31 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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:31 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 00:05:31 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 00:05:31 INFO - Using env: {'DISPLAY': ':0', 00:05:31 INFO - 'HOME': '/home/cltbld', 00:05:31 INFO - 'LANG': 'en_US.UTF-8', 00:05:31 INFO - 'LANGUAGE': 'en_US:en', 00:05:31 INFO - 'LOGNAME': 'cltbld', 00:05:31 INFO - 'MAIL': '/var/mail/cltbld', 00:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:31 INFO - 'MOZ_NO_REMOTE': '1', 00:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:31 INFO - 'NO_EM_RESTART': '1', 00:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:31 INFO - 'PWD': '/builds/slave/test', 00:05:31 INFO - 'SHELL': '/bin/bash', 00:05:31 INFO - 'SHLVL': '1', 00:05:31 INFO - 'TERM': 'linux', 00:05:31 INFO - 'TMOUT': '86400', 00:05:31 INFO - 'USER': 'cltbld', 00:05:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:31 INFO - '_': '/tools/buildbot/bin/python'} 00:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:05:31 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 00:05:31 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 00:05:31 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 00:05:31 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 00:05:31 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 00:05:31 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 00:05:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:05:33 INFO - Installing collected packages: mozsystemmonitor 00:05:33 INFO - Running setup.py install for mozsystemmonitor 00:05:33 INFO - Successfully installed mozsystemmonitor 00:05:33 INFO - Cleaning up... 00:05:33 INFO - Return code: 0 00:05:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:05:33 INFO - Using env: {'DISPLAY': ':0', 00:05:33 INFO - 'HOME': '/home/cltbld', 00:05:33 INFO - 'LANG': 'en_US.UTF-8', 00:05:33 INFO - 'LANGUAGE': 'en_US:en', 00:05:33 INFO - 'LOGNAME': 'cltbld', 00:05:33 INFO - 'MAIL': '/var/mail/cltbld', 00:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:33 INFO - 'MOZ_NO_REMOTE': '1', 00:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:33 INFO - 'NO_EM_RESTART': '1', 00:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:33 INFO - 'PWD': '/builds/slave/test', 00:05:33 INFO - 'SHELL': '/bin/bash', 00:05:33 INFO - 'SHLVL': '1', 00:05:33 INFO - 'TERM': 'linux', 00:05:33 INFO - 'TMOUT': '86400', 00:05:33 INFO - 'USER': 'cltbld', 00:05:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:33 INFO - '_': '/tools/buildbot/bin/python'} 00:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:33 INFO - Downloading/unpacking blobuploader==1.2.4 00:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:35 INFO - Downloading blobuploader-1.2.4.tar.gz 00:05:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:05:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:05:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 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 00:05:36 INFO - Downloading docopt-0.6.1.tar.gz 00:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:05:36 INFO - Installing collected packages: blobuploader, requests, docopt 00:05:36 INFO - Running setup.py install for blobuploader 00:05:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:05:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:05:36 INFO - Running setup.py install for requests 00:05:37 INFO - Running setup.py install for docopt 00:05:37 INFO - Successfully installed blobuploader requests docopt 00:05:37 INFO - Cleaning up... 00:05:37 INFO - Return code: 0 00:05:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:37 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')]} 00:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:37 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')]} 00:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:37 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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:37 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 00:05:37 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 00:05:37 INFO - Using env: {'DISPLAY': ':0', 00:05:37 INFO - 'HOME': '/home/cltbld', 00:05:37 INFO - 'LANG': 'en_US.UTF-8', 00:05:37 INFO - 'LANGUAGE': 'en_US:en', 00:05:37 INFO - 'LOGNAME': 'cltbld', 00:05:37 INFO - 'MAIL': '/var/mail/cltbld', 00:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:37 INFO - 'MOZ_NO_REMOTE': '1', 00:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:37 INFO - 'NO_EM_RESTART': '1', 00:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:37 INFO - 'PWD': '/builds/slave/test', 00:05:37 INFO - 'SHELL': '/bin/bash', 00:05:37 INFO - 'SHLVL': '1', 00:05:37 INFO - 'TERM': 'linux', 00:05:37 INFO - 'TMOUT': '86400', 00:05:37 INFO - 'USER': 'cltbld', 00:05:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:37 INFO - '_': '/tools/buildbot/bin/python'} 00:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:37 INFO - Running setup.py (path:/tmp/pip-lUcANB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:37 INFO - Running setup.py (path:/tmp/pip-f6KRaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:37 INFO - Running setup.py (path:/tmp/pip-jFouhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:37 INFO - Running setup.py (path:/tmp/pip-gGQicZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:37 INFO - Running setup.py (path:/tmp/pip-96K8Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:37 INFO - Running setup.py (path:/tmp/pip-K8Wn89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:38 INFO - Running setup.py (path:/tmp/pip-SiIne_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:38 INFO - Running setup.py (path:/tmp/pip-Eu5O5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:38 INFO - Running setup.py (path:/tmp/pip-IOQDuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:38 INFO - Running setup.py (path:/tmp/pip-eqBX4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:38 INFO - Running setup.py (path:/tmp/pip-8bzbe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:38 INFO - Running setup.py (path:/tmp/pip-48tBSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:38 INFO - Running setup.py (path:/tmp/pip-zDx7Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:38 INFO - Running setup.py (path:/tmp/pip-shCcGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:38 INFO - Running setup.py (path:/tmp/pip-kbXQR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:38 INFO - Running setup.py (path:/tmp/pip-e4zAOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:38 INFO - Running setup.py (path:/tmp/pip-tPMhEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:05:38 INFO - Running setup.py install for manifestparser 00:05:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:05:38 INFO - Running setup.py install for mozcrash 00:05:39 INFO - Running setup.py install for mozdebug 00:05:39 INFO - Running setup.py install for mozdevice 00:05:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Running setup.py install for mozfile 00:05:39 INFO - Running setup.py install for mozhttpd 00:05:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Running setup.py install for mozinfo 00:05:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Running setup.py install for mozInstall 00:05:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Running setup.py install for mozleak 00:05:39 INFO - Running setup.py install for mozlog 00:05:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Running setup.py install for moznetwork 00:05:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:05:39 INFO - Running setup.py install for mozprocess 00:05:40 INFO - Running setup.py install for mozprofile 00:05:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:05:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:05:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:05:40 INFO - Running setup.py install for mozrunner 00:05:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:05:40 INFO - Running setup.py install for mozscreenshot 00:05:40 INFO - Running setup.py install for moztest 00:05:40 INFO - Running setup.py install for mozversion 00:05:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:05:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:05:40 INFO - Cleaning up... 00:05:40 INFO - Return code: 0 00:05:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:40 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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:40 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 00:05:40 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 00:05:40 INFO - Using env: {'DISPLAY': ':0', 00:05:40 INFO - 'HOME': '/home/cltbld', 00:05:40 INFO - 'LANG': 'en_US.UTF-8', 00:05:40 INFO - 'LANGUAGE': 'en_US:en', 00:05:40 INFO - 'LOGNAME': 'cltbld', 00:05:40 INFO - 'MAIL': '/var/mail/cltbld', 00:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:40 INFO - 'MOZ_NO_REMOTE': '1', 00:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:40 INFO - 'NO_EM_RESTART': '1', 00:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:40 INFO - 'PWD': '/builds/slave/test', 00:05:40 INFO - 'SHELL': '/bin/bash', 00:05:40 INFO - 'SHLVL': '1', 00:05:40 INFO - 'TERM': 'linux', 00:05:40 INFO - 'TMOUT': '86400', 00:05:40 INFO - 'USER': 'cltbld', 00:05:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:40 INFO - '_': '/tools/buildbot/bin/python'} 00:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:40 INFO - Running setup.py (path:/tmp/pip-W7Xepq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:40 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)) 00:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:40 INFO - Running setup.py (path:/tmp/pip-BXzOn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:41 INFO - Running setup.py (path:/tmp/pip-L0f7pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:41 INFO - Running setup.py (path:/tmp/pip-lO0lEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:41 INFO - Running setup.py (path:/tmp/pip-Z4xNAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:41 INFO - Running setup.py (path:/tmp/pip-QqwF3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:41 INFO - Running setup.py (path:/tmp/pip-I6XRhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:41 INFO - Running setup.py (path:/tmp/pip-A6TYgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:41 INFO - Running setup.py (path:/tmp/pip-cv9rul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:41 INFO - Running setup.py (path:/tmp/pip-rZtkvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:41 INFO - Running setup.py (path:/tmp/pip-zkhtCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:41 INFO - Running setup.py (path:/tmp/pip-x_gNTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:41 INFO - Running setup.py (path:/tmp/pip-KkJHJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:41 INFO - Running setup.py (path:/tmp/pip-Pjp1jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:41 INFO - Running setup.py (path:/tmp/pip-pvxYPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:41 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)) 00:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:41 INFO - Running setup.py (path:/tmp/pip-g5VCct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:42 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)) 00:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:42 INFO - Running setup.py (path:/tmp/pip-_xGRdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:42 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)) 00:05:42 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)) 00:05:42 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)) 00:05:42 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)) 00:05:42 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)) 00:05:42 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)) 00:05:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:05:42 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 00:05:42 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 00:05:42 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 00:05:42 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 00:05:42 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 00:05:42 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 00:05:43 INFO - Downloading blessings-1.6.tar.gz 00:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:05:44 INFO - Installing collected packages: blessings 00:05:44 INFO - Running setup.py install for blessings 00:05:44 INFO - Successfully installed blessings 00:05:44 INFO - Cleaning up... 00:05:44 INFO - Return code: 0 00:05:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:44 INFO - Reading from file tmpfile_stdout 00:05:44 INFO - Current package versions: 00:05:44 INFO - argparse == 1.2.1 00:05:44 INFO - blessings == 1.6 00:05:44 INFO - blobuploader == 1.2.4 00:05:44 INFO - docopt == 0.6.1 00:05:44 INFO - manifestparser == 1.1 00:05:44 INFO - mozInstall == 1.12 00:05:44 INFO - mozcrash == 0.17 00:05:44 INFO - mozdebug == 0.1 00:05:44 INFO - mozdevice == 0.48 00:05:44 INFO - mozfile == 1.2 00:05:44 INFO - mozhttpd == 0.7 00:05:44 INFO - mozinfo == 0.9 00:05:44 INFO - mozleak == 0.1 00:05:44 INFO - mozlog == 3.1 00:05:44 INFO - moznetwork == 0.27 00:05:44 INFO - mozprocess == 0.22 00:05:44 INFO - mozprofile == 0.28 00:05:44 INFO - mozrunner == 6.11 00:05:44 INFO - mozscreenshot == 0.1 00:05:44 INFO - mozsystemmonitor == 0.0 00:05:44 INFO - moztest == 0.7 00:05:44 INFO - mozversion == 1.4 00:05:44 INFO - psutil == 3.1.1 00:05:44 INFO - requests == 1.2.3 00:05:44 INFO - wsgiref == 0.1.2 00:05:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:44 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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:44 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 00:05:44 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 00:05:44 INFO - Using env: {'DISPLAY': ':0', 00:05:44 INFO - 'HOME': '/home/cltbld', 00:05:44 INFO - 'LANG': 'en_US.UTF-8', 00:05:44 INFO - 'LANGUAGE': 'en_US:en', 00:05:44 INFO - 'LOGNAME': 'cltbld', 00:05:44 INFO - 'MAIL': '/var/mail/cltbld', 00:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:44 INFO - 'MOZ_NO_REMOTE': '1', 00:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:44 INFO - 'NO_EM_RESTART': '1', 00:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:44 INFO - 'PWD': '/builds/slave/test', 00:05:44 INFO - 'SHELL': '/bin/bash', 00:05:44 INFO - 'SHLVL': '1', 00:05:44 INFO - 'TERM': 'linux', 00:05:44 INFO - 'TMOUT': '86400', 00:05:44 INFO - 'USER': 'cltbld', 00:05:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:44 INFO - '_': '/tools/buildbot/bin/python'} 00:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 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)) 00:05:44 INFO - Cleaning up... 00:05:44 INFO - Return code: 0 00:05:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:44 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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:44 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 00:05:44 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 00:05:44 INFO - Using env: {'DISPLAY': ':0', 00:05:44 INFO - 'HOME': '/home/cltbld', 00:05:44 INFO - 'LANG': 'en_US.UTF-8', 00:05:44 INFO - 'LANGUAGE': 'en_US:en', 00:05:44 INFO - 'LOGNAME': 'cltbld', 00:05:44 INFO - 'MAIL': '/var/mail/cltbld', 00:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:44 INFO - 'MOZ_NO_REMOTE': '1', 00:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:44 INFO - 'NO_EM_RESTART': '1', 00:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:44 INFO - 'PWD': '/builds/slave/test', 00:05:44 INFO - 'SHELL': '/bin/bash', 00:05:44 INFO - 'SHLVL': '1', 00:05:44 INFO - 'TERM': 'linux', 00:05:44 INFO - 'TMOUT': '86400', 00:05:44 INFO - 'USER': 'cltbld', 00:05:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:44 INFO - '_': '/tools/buildbot/bin/python'} 00:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:44 INFO - Downloading/unpacking jsonschema 00:05:44 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 00:05:44 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 00:05:44 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 00:05:44 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 00:05:44 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 00:05:44 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 00:05:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:05:46 INFO - Downloading/unpacking functools32 (from jsonschema) 00:05:46 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 00:05:46 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 00:05:46 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 00:05:46 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 00:05:46 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 00:05:46 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 00:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 00:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:05:47 INFO - warning: no files found matching '*.txt' 00:05:47 INFO - no previously-included directories found matching 'build' 00:05:47 INFO - no previously-included directories found matching 'dist' 00:05:47 INFO - no previously-included directories found matching '.git*' 00:05:47 INFO - Installing collected packages: jsonschema, functools32 00:05:47 INFO - Running setup.py install for functools32 00:05:47 INFO - warning: no files found matching '*.txt' 00:05:47 INFO - no previously-included directories found matching 'build' 00:05:47 INFO - no previously-included directories found matching 'dist' 00:05:47 INFO - no previously-included directories found matching '.git*' 00:05:47 INFO - Successfully installed jsonschema functools32 00:05:47 INFO - Cleaning up... 00:05:47 INFO - Return code: 0 00:05:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:47 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 0x7fdbea699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', '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 00:05:47 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 00:05:47 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 00:05:47 INFO - Using env: {'DISPLAY': ':0', 00:05:47 INFO - 'HOME': '/home/cltbld', 00:05:47 INFO - 'LANG': 'en_US.UTF-8', 00:05:47 INFO - 'LANGUAGE': 'en_US:en', 00:05:47 INFO - 'LOGNAME': 'cltbld', 00:05:47 INFO - 'MAIL': '/var/mail/cltbld', 00:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:47 INFO - 'MOZ_NO_REMOTE': '1', 00:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:47 INFO - 'NO_EM_RESTART': '1', 00:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:47 INFO - 'PWD': '/builds/slave/test', 00:05:47 INFO - 'SHELL': '/bin/bash', 00:05:47 INFO - 'SHLVL': '1', 00:05:47 INFO - 'TERM': 'linux', 00:05:47 INFO - 'TMOUT': '86400', 00:05:47 INFO - 'USER': 'cltbld', 00:05:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:47 INFO - '_': '/tools/buildbot/bin/python'} 00:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:47 INFO - Downloading/unpacking flake8 00:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:05:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:05:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:05:50 INFO - no previously-included directories found matching 'docs/_build' 00:05:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:05:50 INFO - Running setup.py install for pep8 00:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:05:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:05:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:05:50 INFO - no previously-included directories found matching 'docs/_build' 00:05:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:05:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:05:50 INFO - Cleaning up... 00:05:50 INFO - Return code: 0 00:05:50 INFO - Running post-action listener: _resource_record_post_action 00:05:50 INFO - Running post-action listener: _start_resource_monitoring 00:05:50 INFO - Starting resource monitoring. 00:05:50 INFO - ##### 00:05:50 INFO - ##### Running install step. 00:05:50 INFO - ##### 00:05:50 INFO - Running pre-action listener: _resource_record_pre_action 00:05:50 INFO - Running main action method: install 00:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:50 INFO - Reading from file tmpfile_stdout 00:05:50 INFO - Detecting whether we're running mozinstall >=1.0... 00:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:05:50 INFO - Reading from file tmpfile_stdout 00:05:50 INFO - Output received: 00:05:50 INFO - Usage: mozinstall [options] installer 00:05:50 INFO - Options: 00:05:50 INFO - -h, --help show this help message and exit 00:05:50 INFO - -d DEST, --destination=DEST 00:05:50 INFO - Directory to install application into. [default: 00:05:50 INFO - "/builds/slave/test"] 00:05:50 INFO - --app=APP Application being installed. [default: firefox] 00:05:50 INFO - mkdir: /builds/slave/test/build/application 00:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:06:05 INFO - Reading from file tmpfile_stdout 00:06:05 INFO - Output received: 00:06:05 INFO - /builds/slave/test/build/application/firefox/firefox 00:06:05 INFO - Running post-action listener: _resource_record_post_action 00:06:05 INFO - ##### 00:06:05 INFO - ##### Running run-tests step. 00:06:05 INFO - ##### 00:06:05 INFO - Running pre-action listener: _resource_record_pre_action 00:06:05 INFO - Running main action method: run_tests 00:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:06:05 INFO - Python 2.7.3 00:06:05 INFO - Return code: 0 00:06:05 INFO - grabbing minidump binary from tooltool 00:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:05 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 0x22cb160>, '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 0x22cc060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cc4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:06:05 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 00:06:05 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 00:06:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:06:05 INFO - Return code: 0 00:06:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:06:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:06:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:06:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:06:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:06:06 INFO - Return code: 0 00:06:06 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/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 00:06:06 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/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 00:06:06 INFO - Using env: {'DISPLAY': ':0', 00:06:06 INFO - 'HOME': '/home/cltbld', 00:06:06 INFO - 'LANG': 'en_US.UTF-8', 00:06:06 INFO - 'LANGUAGE': 'en_US:en', 00:06:06 INFO - 'LOGNAME': 'cltbld', 00:06:06 INFO - 'MAIL': '/var/mail/cltbld', 00:06:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:06:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:06 INFO - 'MOZ_NO_REMOTE': '1', 00:06:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:06:06 INFO - 'NO_EM_RESTART': '1', 00:06:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:06 INFO - 'PWD': '/builds/slave/test', 00:06:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:06:06 INFO - 'SHELL': '/bin/bash', 00:06:06 INFO - 'SHLVL': '1', 00:06:06 INFO - 'TERM': 'linux', 00:06:06 INFO - 'TMOUT': '86400', 00:06:06 INFO - 'USER': 'cltbld', 00:06:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693', 00:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:06 INFO - '_': '/tools/buildbot/bin/python'} 00:06:06 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/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 00:06:07 INFO - mozversion application_buildid: 20160420213010 00:06:07 INFO - mozversion application_changeset: d9fdbad8f079c7801abdef70df2cad93efcce797 00:06:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:06:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:06:07 INFO - mozversion application_name: Firefox 00:06:07 INFO - mozversion application_remotingname: firefox-dev 00:06:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:06:07 INFO - mozversion application_vendor: Mozilla 00:06:07 INFO - mozversion application_version: 47.0a2 00:06:07 INFO - mozversion platform_buildid: 20160420213010 00:06:07 INFO - mozversion platform_changeset: d9fdbad8f079c7801abdef70df2cad93efcce797 00:06:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:06:07 INFO - mozversion platform_version: 47.0a2 00:06:07 INFO - using testdate: 1461222367 00:06:07 INFO - actual date: 1461222367 00:06:07 INFO - starting webserver on 'localhost:48581' 00:06:07 INFO - SUITE-START | Running 2 tests 00:06:07 INFO - TEST-START | dromaeo_css 00:06:07 INFO - operating with platform_type : linux_ 00:06:07 INFO - Initialising browser for dromaeo_css test... 00:06:07 INFO - TEST-INFO | started process 8334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg_73u1/profile http://localhost:48581/getInfo.html) 00:06:10 INFO - PROCESS | 8334 | 00:06:10 INFO - PROCESS | 8334 | (process:8408): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:06:11 INFO - PROCESS | 8334 | __metrics Screen width/height:1600/1200 00:06:11 INFO - PROCESS | 8334 | colorDepth:24 00:06:11 INFO - PROCESS | 8334 | Browser inner width/height: 1024/697 00:06:11 INFO - PROCESS | 8334 | __metrics 00:06:12 ERROR - PROCESS | 8334 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 00:06:13 INFO - TEST-INFO | 8334: exit 0 00:06:13 INFO - Browser initialized. 00:06:13 INFO - Running cycle 1/1 for dromaeo_css test... 00:06:13 INFO - TEST-INFO | started process 8459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg_73u1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:06:14 INFO - PROCESS | 8459 | 00:06:14 INFO - PROCESS | 8459 | (process:8524): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:06:24 INFO - PROCESS | 8459 | RSS: Main: 151281664 00:06:24 INFO - PROCESS | 8459 | 00:07:14 INFO - PROCESS | 8459 | 1461222434519 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] 00:09:22 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48581/tests/dromaeo/cssquery-ext.html) 00:09:23 INFO - PROCESS | 8459 | RSS: Main: 153931776 00:09:23 INFO - PROCESS | 8459 | 00:12:25 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-ext.html (next: http://localhost:48581/tests/dromaeo/cssquery-jquery.html) 00:12:25 INFO - PROCESS | 8459 | RSS: Main: 153317376 00:12:25 INFO - PROCESS | 8459 | 00:15:27 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48581/tests/dromaeo/cssquery-mootools.html) 00:15:28 INFO - PROCESS | 8459 | RSS: Main: 152436736 00:15:28 INFO - PROCESS | 8459 | 00:18:29 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48581/tests/dromaeo/cssquery-prototype.html) 00:18:30 INFO - PROCESS | 8459 | RSS: Main: 153456640 00:18:30 INFO - PROCESS | 8459 | 00:21:32 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48581/tests/dromaeo/cssquery-yui.html) 00:21:33 INFO - PROCESS | 8459 | RSS: Main: 152682496 00:21:33 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-yui.html (next: http://localhost:48581/tests/dromaeo/cssquery-dojo.html) 00:24:35 INFO - PROCESS | 8459 | RSS: Main: 154558464 00:24:35 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | __start_tp_report 00:24:35 INFO - PROCESS | 8459 | _x_x_mozilla_page_load 00:24:35 INFO - PROCESS | 8459 | _x_x_mozilla_page_load_details 00:24:35 INFO - PROCESS | 8459 | |i|pagename|runs| 00:24:35 INFO - PROCESS | 8459 | |0;dojo.html;3241.529978153168;3361.966380336196;3370.5618269624947;3397.116749645093;3417.8632854685816;5414.431484694104;5434.782608695652;5442.809501667442;5459.344878614572;5491.670499770012;5449.3188351456065;5451.127819548873;5459.290292262001;5470.972645136779;5481.972590137054;4902.901941961159;5015.172496538067;5025.14572522672;5073.771680274396;5111.437741848394;4856.980034192824;4992.750362481879;5012.248162775594;5016.774245158977;5176.870578235536;4967.279744437054;4977.900441991176;5024.397072351305;5039.647224694273;5057.5701065409485;5013.448520662724;5018.548330650241;5020.2218656108;5031;5051.318072060299;4752.4297084349755;4906;4957.281194226853;4962.503749625044;5014.272930425104;5166.689998600096;5168.095583272912;5185.55922746567;5219.112750832368;5269.446708095671;5784.1902133701315;5837.562182836305;5843.590948633598;5855.795047173328;5861.589688721791;5864;5894.528437724972;5914.260717410324;5980.671063091529;6000.0999850022845;5412.675239485643;5454.263674403905;5465.945340546623;5471.808486702986;5481.342238931354;5849.239598852122;5925;5936.584439089309;5936.9406305937255;5939.970300148471;5763.818417224459;5776.191333213354;5803.709814509258;5809.767609295581;5866.794662186803;5786.681732504669;5788.131780232999;5794.449527294901;5800.158976948319;5800.477956983892;5633.605647604629;5744;5749.338826035059;5752.856178595485;5789.942100579025;5723.313202415737;5725.799597014085;5757.165211044375;5760.481556659921;5822.621529600562;4421.911561768747;4434.157510073076;4438.356438316426;4453.532379100213;4484.372187893698;3952.960470395317;3997.240524300432;4029.6373326400767;4034.6772258219858;4042.939355909664;5468.425815289417;5547.639403438763;5645.237892884408;5652.519535839418;5653.773849046074;5793.652380857162;5851.9173952818865;5857.297124345106;5861.17943487912;5885.61743486672;5520.53075488588;5530.308711411074;5578.246936663499;5607.383187849333;5624.072028115397;5067.569256613156;5072.923906141411;5075.289459475676;5092.592592592584;5096.592272618182;6153.84615384619;6208.068789681584;6237.220347456568;6244.843878903063;6250.874982500324;5698.2592263005545;5867.853303667443;5922.7334769936315;5978.551608629283;5978.790742323998;6201.086685608785;6230.844228894314;6232.470240029648;6249.312575616769;6261.96869015652;5795.449432304093;5799;5806.583317151284;5863;5892.587518873637;5655.519280861173;5823.941760582509;5883;5892.823215303548;5915.231019967377;5738.225339579103;5775.306963164279;5776.277965254343;5785.3636100028125;5786.797462088806;5583.385827559046;5680.289963754531;5749.597528172988;5778.94221057784;5783.132530120515;5568.49883510486;5625.043742563856;5661.575381846295;5671.404502527175;5695.772169113189;5721.22763426932;5740.339860916049;5752.942470575241;5755.251817263729;5758.827235182951;5479.945200547943;5558.694271814928;5634.549236061023;5643.661380317194;5709.685967271674 00:24:35 INFO - PROCESS | 8459 | |1;ext.html;514.93820741511;564.6188822544781;564.652738565782;585.2479563760567;592.8221533539939;40473;40947.18105637885;41017.589824101786;41158.17683646325;41279.79360103199;45295.773521132345;45838.31242531356;46052;46155.769221153845;46218;8800.691975780848;8975.192232699055;9015.729528114167;9030.954845225764;9081.59132839024;8706;8957.596908139118;8962.73111806647;8990.550472476383;8994.595243214038;9141.131592498701;9156.175944165025;9246.214071803905;9258.166764991149;9276.860847087299;9157.496337701425;9166.724998250063;9192.172704456563;9200.769980750501;9211.078892110801;8968.865467018;9079.68221112258;9135.406198597137;9167.174954254082;9209.309301802392;37141.442878356844;37190.4421433676;37455.43816842749;37516.249675006344;37552.24895502075;3715.5912849586525;3782.659560639528;3808.6762625176893;4320.179165958458;4341.45731783527;33444.66555334464;33636.32727345464;33668;33742.83128584366;33869.49195762065;4098.344264917599;4178.101708132735;4192.24539582875;4263.296556068245;4319.200947824663;298020;299850;300309;300436.9999999978;300850;46686.5331346689;46887.1245150197;46966.53033469622;46998;68824;45548.54451455509;45713.77143114263;45746;45750.77124614356;45837.77081114573;16976.405825796286;17283.481495555152;17287.049212293445;17338.13309334528;17364.91317543404;13703.657408564866;13844.30778461073;13845.446182152602;13853.376598053112;13950.23273719955;15838.574528292509;15947.36210551565;15979.201039947957;15982.280797364147;16056.678866422606;6006.939930600725;6245.125682404467;6248.156498872685;6275.121482992385;6282.308946015934;1084.6203828660064;1087.3856271206744;1094.179365475893;1135.5287555664306;1150.2810743285447;30573.541396879064;30646.38707225843;30656.147008888354;31412;31600.73597056092;1128.1426116151783;1162.7674465107013;1192.9919218260557;1197.4910662968205;1226.7546490701716;15707.764383534257;15893.284802183929;16173.514794556182;16254.349826007065;16374.426895058854;335499;528403;531489;536420;767864;64890;65833;66001.66999164973;66083.33916660772;66113.33886661072;1468.5961360625913;1475.4172102019643;1480.208088672555;1495.2374289112631;1502.8346881842988;31706.841465792524;32260.35479290448;32803;32857;32857.67142328642;54475.72762136164;55453;55472;55482.44517554934;55654.44345556493;317707;321518;323867;324324;324611;47649;47999;48226;49533;49776.50223497864;51148.23277650764;51155;51790.482095178566;52888.735556321975;53017;43320.78339608282;43346.78326608347;44058.55941440545;44610.330845038;44830.103397931205;43839.56160438355;44355.77822110998;44462.333065003404;44474;44863;42134.36798448087;42945.570544294154;42986.57013429826;43151.784241078596;43457.56542434662;35855.82072089623;35910.64089359073;36732.26535469222;37031.62968370282;37149.25701485901;28052.158435246976;28500.42999140047;28596.142115736562;28653.713462865104;28682.85658571777 00:24:35 INFO - PROCESS | 8459 | |2;jquery.html;371.22043708212755;383.57614835606654;385.07197653654697;386.7157639135236;390.8885967499263;18626.254949802027;18639.25442982279;19448.805511944876;19714.112864921077;20444.59110817783;17526.123693815323;17565.82434175658;17750.733738993895;17803.198856051476;17927.73108403375;5166.689998600096;5433.402325744165;5464.098423760075;5469.535089517396;5806.738696758656;5760.942390576103;5811.244538210027;5815.73829177688;5842.707864606774;5855.648661080328;5424.972875135619;5512.586556008296;5815.360310365878;5827.184194212814;5877.235959325281;5353.304070470834;5407.918416316733;5412.161115027177;5440.700761458118;5442.455754424565;5225.346831646044;5253.55344795689;5256.185291279858;5264.210368444726;5317.361916569997;13911.30443477822;14038;14214;14238.501652442219;14245.572632821031;2281.840271181018;2295.4490922178725;2386.7255265644326;2408.2895545813853;2934.0611004478574;10164.44095574743;10433.269671123024;10461.476926153739;10494.79010419795;10498.737531561696;1868.822461866134;1957.4323446200585;1990.790966948464;2015.606956643455;2060.577581595769;65125;68584.3141568583;68721.65639171822;69285.65357173182;69383;10474.528646210938;10495.422751748727;10735.83896241557;10939.28894621847;11377;13503.324833758274;14238.074525155831;14869.628259293388;15102.093874367572;15139.318730657147;8067.878981815277;8216.876746848802;8447.155284471626;8499.830003399897;8506.957465212634;8058.677652893936;8061.4760040597175;8154.347652187811;8197.590120493951;8294.958525207336;4647.279671650899;4652.95347046532;4677.579017888338;4794.7362895040405;4802.567768900815;1952.541152829084;1955.1495099631422;1971;2002.6895831146196;2008.447676888838;985.9063388978036;1010.8989101089833;1029.6447725534679;1039.6413237433226;1061.6496556136456;17495.912520437316;17525.757734818846;17806.554836129202;18146.45560633183;18492.167852446404;979.4123525884555;1014.3171311880183;1083.34999000599;1092.093562343253;1095.8465814785936;10099.277483308366;10257.897421025695;10262.43556604394;10294.794104117876;10443.425611591436;401939;405288;409157;409744;424978;68021.3197868015;71173.64413177902;72141.2785872145;72694.63652681808;74030;1022.7852151048214;1067.2369255981855;1068.2842495528014;1083.8536797532233;1084.6908631040117;16163.67672646564;16391.016539007698;16503.422380216634;16505.66988660196;16607;34470.65529344675;35825.46261806127;36346.8182659085;36536.634633653324;36858.8157059213;48788;48966.26550601815;49168.01663966629;49551.50448495469;50097.49902500928;8357.623906924082;8464.449810762528;8667.089955554577;8798.780030499289;8806.471611703319;12681.93659031699;13185.40665670028;13263.071584988958;13385.598432047054;13589.388477518338;11962.76074478523;11974.700632484257;12099.697507562381;12175.269483830643;12200.572979945659;12054.51781928713;12085.154039217523;12149.616764432514;12182.390880455765;12291.692707682021;12202.206856554296;12373.443195056065;12473.93763031179;12556.246625202517;12763.936180319039;8293.21214484623;8377.49735015901;8504.489730616182;8642.56787160652;8742.082081381363;8639.784005399664;11252.943735281271;11526.82709759371;11689.415529223335;11717.707057323634 00:24:35 INFO - PROCESS | 8459 | |3;mootools.html;1583.3349993002937;1585.1361008250503;1846.4645252876667;1938.932137375192;1984.474114359694;7514.774556763306;8342;8506.319494440446;8710.651573937042;8734.170253825885;8393.16068393162;8404;8480.787980300496;8494.150584941503;8494.660213591449;2429.8177636677233;2459.7540245975347;2464.5194187133516;2464.7658472445087;2474;2398.9444644356427;2420.080369459603;2441.2554170977846;2445.1808644104244;2445.4742230420457;2422.4065104049446;2429.137656132074;2450.901963921441;2467.3214865911837;2474.1958863369387;2409.6024156014414;2412.0954642009247;2446.1805295226122;2448.3634255093625;2458.2625212436287;2402.6636270922086;2414.9154779582805;2431.805455563551;2433.9634905476432;2436.658867758515;8594.226519613265;8603.483790972561;8653.480791152488;8687.565621718888;8692.174243446863;5261.973690131563;5372.382176049765;5380.704061276629;5387;5390.8921821563345;3293.9835300823584;3335.7664963452567;3357.8153201573905;3386.305807309496;3389.084947064279;1094.9014588687057;1097.3470784882982;1105.6517197082974;1107.2747350485445;1107.6067995861433;12276.754464910651;12300.876991230063;12307.200031997982;12331.075169362333;12368.81446778299;4533.342665313577;4596.264597664424;4612.538746125428;4619.3994780678295;4640.744759038285;10244.948775256076;10293.53679084443;10334.328268662513;10343.94828025855;10394.844077338847;5235.554977826928;5325.627206095536;5331.70675612845;5352.705601191894;5371.194320851825;4166.58334166587;4680.719156850531;4772.952270477251;4793.0413917216;4810.302506136591;3857;3962.3660214365564;3978.124812541294;3993;4045.7572545647354;1273.6882558156915;1288.2592509306999;1297.47452281826;1302.2316833068535;1302.5115581656878;1175.9000484958874;1198.0415667465993;1319.168923578159;1443;1470.264867566217;8169.223923727236;8173.795655108551;8214.753557393287;8262.049864265566;8273.46222495548;514.9639525233198;515.9045576568346;524.8976449592293;529.3912001198653;529.4943329120681;6008.429199226067;6113.052476866093;6145.5698101133385;6156.846078848064;6166.136740856284;10315.638952636771;10671;10674.466276686135;10762.515686794113;10785;9762.853557196506;10404.219683523766;10543.894561054445;10577.84133238002;10611.257211995086;8073.434859559775;8082.919170808216;8131.512109273463;8133.430659853753;8177.100518942912;7912.0505539335645;7988.720394786154;8027.117017127995;8250.917490825255;8295.170482951657;9470.573824178065;9525;9590.904090959;9632.133108020313;9727.562259698188;9746.951265243628;9750.317477776487;9884.950575247078;9962.601495940082;10071.093601575893;6747.932520674731;7136.785896423115;7334.046573945353;7550.169481356937;7717.382609391123;8059.476134051268;8107.594620269081;8122.431429799857;8141.14517975604;8172.223638754309;7198.388137008413;7328.303811137934;7579.772606821804;7585.127710313384;7672.117706463828;7149.428045756223;7229.09636295463;7287.927120728725;7291.125064992235;7345.632718363953;7732.613369331623;7785.883211751715;7804.414668899742;7814.101378341564;7822.491538050009;6662.133922590032;6715.26132125456;6733.427658648874;6735.090762746966;6941.757038503628;7073.469489788389;7080.079589653312;7098.219195888345;7100.964495177491;7116.359527642537 00:24:35 INFO - PROCESS | 8459 | |4;prototype.html;366.5949126215532;368.33331669677875;370.54608105071276;371.2463698691657;376.1142509390386;6243.906341404882;6269.968650156754;6281.089242059898;6297.842553936154;6371.713272902719;6064.484518815906;6150.907736383958;6190.907136392958;6192.380761923817;6209.813705588839;4662.557057079589;4760.90478190436;4830.3237546743485;4831.396075490564;4836.564709176182;4745.857624271277;4755.809767609291;4762.119007983534;4802.711837289757;4815.831445899395;4716.599089077433;4737.834175803848;4740.857774266778;4751.524847515256;4786.736729479877;4760.9049918518585;4778.928316075262;4787.832425865078;4797.088553174885;4800.135975524404;4210.115875666083;4215.59951804578;4215.641670458015;4217.746935183868;4227.577242275778;5843.883122337572;5895.498882594985;5916;5917.497012753921;5933.792317268875;5359.785608575652;5555.833325000256;5559.722013899289;5561.5272701820395;5584.748686309126;6566.80299591013;6570.63861487618;6579.17760279965;6592.373724496165;6617.503687223478;4551.249043907751;4584.701994370355;4593.701409408412;4594.402727645418;4632.953670463319;6817.488688348394;6846;6855.211650660138;6875;6885.483588730865;4643.721376717408;4668.976655116703;4733.928991065137;4739.578126562086;4756.500567440438;4770.76146192689;4797.472278049412;4799.3041009053495;4801.207800712843;4807.014562014779;5516.7517461714315;5518.310211223597;5522.530584900248;5525.171224316305;5555.166724991283;6624.304448032984;6626.337366263335;6631.834204144935;6640.701168447432;6644.4020038196795;1654.4126834973652;1679.706051440993;1699.923503442348;1701.9829801701824;1708.4105983435695;1110.9888901111046;1116.0680831505622;1124.0894875151155;1124.2242852431796;1136.778328225988;6333.651649159248;6361.236651601837;6403.391677790602;6403.519736019817;6407.711652975628;6732.764353247613;6767.052612634235;6793.218779840382;6795.218549866829;6816.556923799937;6312.368763123743;6325.177726895567;6333.809985700436;6351.55539112267;6379.457746091634;3630.3102410541915;3657.9634203658156;3663.9267214656093;3668.944965825515;3670.908227294339;7196.748113815991;7283.890741638879;7343.48595598303;7355.521891077063;7358.448116391185;6945.548539344926;6996.825079372955;7056.364927156478;7081;7084.610346430995;7290.927090729025;7333.339999400079;7335.119785625652;7346.412287017026;7357.411407087528;6771.119754431892;6789.456843452611;6894.620795856276;6906.205786334636;6913.3777959983845;6683.264840867598;6783.423409010092;6797.524173308018;6800.013997970168;6809.114815074008;7255.52839065459;7314.232005639331;7337.229590893093;7344.15542212631;7381.483296169216;4547.499775024811;4570.862874113782;4577.816887324603;4613.400257966443;4644.883877903079;6838.794836154724;6839.281875403011;6847.21257055445;6882.827929301808;6893.103896493424;6441.355864413521;6666.866662666816;6697;6704.262531121671;6706.362895524917;6637.269900311058;6650.334966503311;6676.432503237279;6678.23200331968;6680;6526.053722210348;6527.412532872065;6567.671616419256;6580.539362244597;6591.110200122922;6604.24051234095;6726.293739157318;6729.798106056826;6736.124303840469;6756.628385438651;6534.640594767143;6548.116004339353;6559.212894452506;6572.967135164294;6616.305287944697 00:24:35 INFO - PROCESS | 8459 | |5;yui.html;789.6604460082162;801.118769353711;815.6044318505527;821.3183058061808;910.1808372464782;14861.182634955074;14933.5519934402;15004.099754014767;15053.47312844052;15107.093574385532;13369.465221391132;13397.665058373546;13413.262270575115;13427;13508.797368039463;775.4998026273065;932.7388331267256;952.2334520710825;952.5094576293214;954.1746389373211;942.6653537994016;945.5036106044347;945.5981207986613;948.8908775490838;954.7231302922145;997.7006897930592;998.1116806042628;1007.6775431861807;1009.9242556808232;1019.8776146862386;1004.9949750251238;1005.0301459091938;1005.7938122684868;1006.9949650251775;1009.2783659683362;741.3587247031332;743.5612988336907;745.5191401545973;746.2015643261713;748.5733132114697;14212.644683882882;14333.856661433356;14344.49794257196;14653.6336591585;14763;13939.581812545639;14168.716625667428;14228.715425691531;14230.786538201935;14284.928575357057;10784.13726901846;11050.723731906686;11918.404079795975;12005.519779208822;12211;3945.171513982067;3950.071733142709;3964.682825373963;3980.144268982183;4028.7179897407195;48102.518974810155;48111.278330825065;48281.51718482805;48521.75739121282;48532.514674853155;9581.233501319877;9643.951780241054;9912.05835445646;9972.252081093948;10394.584216631401;19131.13909874059;19213.519662008563;19281.903590482238;19316.32392866243;19445.31941382045;7878.330341920886;8131.83736325282;8143.267105960492;8244.54654993969;8312.21034001769;4378.16814805186;4384.167008268419;4397.428334316583;4421.9336709949375;4505.05393867285;3297.258116923673;3354.3626710924846;3372.274960883373;3388.034410193083;3404.472306792451;595.9016762234182;605.5337390209514;611.6146827498648;614.0942110387233;616.1958643969663;570.2586637371401;589.5018709190726;591.8461200088008;592.1059200607115;594.1266338482424;7763.92236077632;7833.255840695125;7877.7242796503;7999;8067.677292908218;580.6312991250586;634.6002018728171;645.8030300758314;646.3052218864739;647.821848991531;3664.926701465956;3705.81470926458;3808.7524310919703;3855.4602355670227;3941.1526521797377;56394.7180264096;57110;57887.13169302464;58106.4189358101;58135;48861;50058;50432.243516347284;50508.49491505112;51587.48412515827;47157.76421117873;47325.29012064822;47899.281510777364;48132.27801582909;48150.518494814605;7396.149442814145;7486;7514.736984205527;7562.395008399425;7597.430192735677;35861.820690897424;35920.4611930816;36732.26535469329;36909.81545092257;37246.44130338101;40961.795191023855;42099.57900420957;43388;45986.54013459956;46790.298145528526;9623.711288661352;10066.69799906004;10210.948945255226;10276.280660353703;10310.690679279634;10231;10390.220733445172;10393.792124157324;10563.524641391003;10910.890891090987;9900.702978910644;10040.598376064876;10182.687348752048;10241.539130739284;10394.792104158027;9140;9157.587908544265;9350.018248084125;9902.451832805757;9950.751231219278;9960.103590676874;10068.446235456828;10247.180225582084;10260.43567603759;10333.948330258301;8835.293176545989;8843.557822108998;8983.416077955173;9015.368924175245;9090.545472726206;8274.29668478186;8930.106989301277;8935.865962010444;9000.63997440095;9105.544722763967 00:24:35 INFO - PROCESS | 8459 | __end_tp_report 00:24:35 INFO - PROCESS | 8459 | __start_cc_report 00:24:35 INFO - PROCESS | 8459 | _x_x_mozilla_cycle_collect,327 00:24:35 INFO - PROCESS | 8459 | __end_cc_report 00:24:35 INFO - PROCESS | 8459 | __startTimestamp1461223475678__endTimestamp 00:24:35 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | ------- Summary: start ------- 00:24:35 INFO - PROCESS | 8459 | Number of tests: 6 00:24:35 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | [#0] dojo.html Cycles:165 Average:5446.80 Median:5653.77 stddev:604.75 (10.7%) stddev-sans-first:581.33 00:24:35 INFO - PROCESS | 8459 | Values: 3241.5 3362.0 3370.6 3397.1 3417.9 5414.4 5434.8 5442.8 5459.3 5491.7 5449.3 5451.1 5459.3 5471.0 5482.0 4902.9 5015.2 5025.1 5073.8 5111.4 4857.0 4992.8 5012.2 5016.8 5176.9 4967.3 4977.9 5024.4 5039.6 5057.6 5013.4 5018.5 5020.2 5031.0 5051.3 4752.4 4906.0 4957.3 4962.5 5014.3 5166.7 5168.1 5185.6 5219.1 5269.4 5784.2 5837.6 5843.6 5855.8 5861.6 5864.0 5894.5 5914.3 5980.7 6000.1 5412.7 5454.3 5465.9 5471.8 5481.3 5849.2 5925.0 5936.6 5936.9 5940.0 5763.8 5776.2 5803.7 5809.8 5866.8 5786.7 5788.1 5794.4 5800.2 5800.5 5633.6 5744.0 5749.3 5752.9 5789.9 5723.3 5725.8 5757.2 5760.5 5822.6 4421.9 4434.2 4438.4 4453.5 4484.4 3953.0 3997.2 4029.6 4034.7 4042.9 5468.4 5547.6 5645.2 5652.5 5653.8 5793.7 5851.9 5857.3 5861.2 5885.6 5520.5 5530.3 5578.2 5607.4 5624.1 5067.6 5072.9 5075.3 5092.6 5096.6 6153.8 6208.1 6237.2 6244.8 6250.9 5698.3 5867.9 5922.7 5978.6 5978.8 6201.1 6230.8 6232.5 6249.3 6262.0 5795.4 5799.0 5806.6 5863.0 5892.6 5655.5 5823.9 5883.0 5892.8 5915.2 5738.2 5775.3 5776.3 5785.4 5786.8 5583.4 5680.3 5749.6 5778.9 5783.1 5568.5 5625.0 5661.6 5671.4 5695.8 5721.2 5740.3 5752.9 5755.3 5758.8 5479.9 5558.7 5634.5 5643.7 5709.7 00:24:35 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | [#1] ext.html Cycles:180 Average:56279.54 Median:43069.18 stddev:108977.87 (253.0%) stddev-sans-first:109203.15 00:24:35 INFO - PROCESS | 8459 | Values: 514.9 564.6 564.7 585.2 592.8 40473.0 40947.2 41017.6 41158.2 41279.8 45295.8 45838.3 46052.0 46155.8 46218.0 8800.7 8975.2 9015.7 9031.0 9081.6 8706.0 8957.6 8962.7 8990.6 8994.6 9141.1 9156.2 9246.2 9258.2 9276.9 9157.5 9166.7 9192.2 9200.8 9211.1 8968.9 9079.7 9135.4 9167.2 9209.3 37141.4 37190.4 37455.4 37516.2 37552.2 3715.6 3782.7 3808.7 4320.2 4341.5 33444.7 33636.3 33668.0 33742.8 33869.5 4098.3 4178.1 4192.2 4263.3 4319.2 298020.0 299850.0 300309.0 300437.0 300850.0 46686.5 46887.1 46966.5 46998.0 68824.0 45548.5 45713.8 45746.0 45750.8 45837.8 16976.4 17283.5 17287.0 17338.1 17364.9 13703.7 13844.3 13845.4 13853.4 13950.2 15838.6 15947.4 15979.2 15982.3 16056.7 6006.9 6245.1 6248.2 6275.1 6282.3 1084.6 1087.4 1094.2 1135.5 1150.3 30573.5 30646.4 30656.1 31412.0 31600.7 1128.1 1162.8 1193.0 1197.5 1226.8 15707.8 15893.3 16173.5 16254.3 16374.4 335499.0 528403.0 531489.0 536420.0 767864.0 64890.0 65833.0 66001.7 66083.3 66113.3 1468.6 1475.4 1480.2 1495.2 1502.8 31706.8 32260.4 32803.0 32857.0 32857.7 54475.7 55453.0 55472.0 55482.4 55654.4 317707.0 321518.0 323867.0 324324.0 324611.0 47649.0 47999.0 48226.0 49533.0 49776.5 51148.2 51155.0 51790.5 52888.7 53017.0 43320.8 43346.8 44058.6 44610.3 44830.1 43839.6 44355.8 44462.3 44474.0 44863.0 42134.4 42945.6 42986.6 43151.8 43457.6 35855.8 35910.6 36732.3 37031.6 37149.3 28052.2 28500.4 28596.1 28653.7 28682.9 00:24:35 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | [#2] jquery.html Cycles:180 Average:25106.06 Median:11252.58 stddev:67355.39 (598.6%) stddev-sans-first:67518.74 00:24:35 INFO - PROCESS | 8459 | Values: 371.2 383.6 385.1 386.7 390.9 18626.3 18639.3 19448.8 19714.1 20444.6 17526.1 17565.8 17750.7 17803.2 17927.7 5166.7 5433.4 5464.1 5469.5 5806.7 5760.9 5811.2 5815.7 5842.7 5855.6 5425.0 5512.6 5815.4 5827.2 5877.2 5353.3 5407.9 5412.2 5440.7 5442.5 5225.3 5253.6 5256.2 5264.2 5317.4 13911.3 14038.0 14214.0 14238.5 14245.6 2281.8 2295.4 2386.7 2408.3 2934.1 10164.4 10433.3 10461.5 10494.8 10498.7 1868.8 1957.4 1990.8 2015.6 2060.6 65125.0 68584.3 68721.7 69285.7 69383.0 10474.5 10495.4 10735.8 10939.3 11377.0 13503.3 14238.1 14869.6 15102.1 15139.3 8067.9 8216.9 8447.2 8499.8 8507.0 8058.7 8061.5 8154.3 8197.6 8295.0 4647.3 4653.0 4677.6 4794.7 4802.6 1952.5 1955.1 1971.0 2002.7 2008.4 985.9 1010.9 1029.6 1039.6 1061.6 17495.9 17525.8 17806.6 18146.5 18492.2 979.4 1014.3 1083.3 1092.1 1095.8 10099.3 10257.9 10262.4 10294.8 10443.4 401939.0 405288.0 409157.0 409744.0 424978.0 68021.3 71173.6 72141.3 72694.6 74030.0 1022.8 1067.2 1068.3 1083.9 1084.7 16163.7 16391.0 16503.4 16505.7 16607.0 34470.7 35825.5 36346.8 36536.6 36858.8 48788.0 48966.3 49168.0 49551.5 50097.5 8357.6 8464.4 8667.1 8798.8 8806.5 12681.9 13185.4 13263.1 13385.6 13589.4 11962.8 11974.7 12099.7 12175.3 12200.6 12054.5 12085.2 12149.6 12182.4 12291.7 12202.2 12373.4 12473.9 12556.2 12763.9 8293.2 8377.5 8504.5 8642.6 8742.1 8639.8 11252.9 11526.8 11689.4 11717.7 00:24:35 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | [#3] mootools.html Cycles:180 Average:6011.41 Median:529.44 stddev:3215.93 (607.4%) stddev-sans-first:3207.73 00:24:35 INFO - PROCESS | 8459 | Values: 1583.3 1585.1 1846.5 1938.9 1984.5 7514.8 8342.0 8506.3 8710.7 8734.2 8393.2 8404.0 8480.8 8494.2 8494.7 2429.8 2459.8 2464.5 2464.8 2474.0 2398.9 2420.1 2441.3 2445.2 2445.5 2422.4 2429.1 2450.9 2467.3 2474.2 2409.6 2412.1 2446.2 2448.4 2458.3 2402.7 2414.9 2431.8 2434.0 2436.7 8594.2 8603.5 8653.5 8687.6 8692.2 5262.0 5372.4 5380.7 5387.0 5390.9 3294.0 3335.8 3357.8 3386.3 3389.1 1094.9 1097.3 1105.7 1107.3 1107.6 12276.8 12300.9 12307.2 12331.1 12368.8 4533.3 4596.3 4612.5 4619.4 4640.7 10244.9 10293.5 10334.3 10343.9 10394.8 5235.6 5325.6 5331.7 5352.7 5371.2 4166.6 4680.7 4773.0 4793.0 4810.3 3857.0 3962.4 3978.1 3993.0 4045.8 1273.7 1288.3 1297.5 1302.2 1302.5 1175.9 1198.0 1319.2 1443.0 1470.3 8169.2 8173.8 8214.8 8262.0 8273.5 515.0 515.9 524.9 529.4 529.5 6008.4 6113.1 6145.6 6156.8 6166.1 10315.6 10671.0 10674.5 10762.5 10785.0 9762.9 10404.2 10543.9 10577.8 10611.3 8073.4 8082.9 8131.5 8133.4 8177.1 7912.1 7988.7 8027.1 8250.9 8295.2 9470.6 9525.0 9590.9 9632.1 9727.6 9747.0 9750.3 9885.0 9962.6 10071.1 6747.9 7136.8 7334.0 7550.2 7717.4 8059.5 8107.6 8122.4 8141.1 8172.2 7198.4 7328.3 7579.8 7585.1 7672.1 7149.4 7229.1 7287.9 7291.1 7345.6 7732.6 7785.9 7804.4 7814.1 7822.5 6662.1 6715.3 6733.4 6735.1 6941.8 7073.5 7080.1 7098.2 7101.0 7116.4 00:24:35 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | [#4] prototype.html Cycles:180 Average:5568.18 Median:6329.41 stddev:1691.90 (26.7%) stddev-sans-first:1650.99 00:24:35 INFO - PROCESS | 8459 | Values: 366.6 368.3 370.5 371.2 376.1 6243.9 6270.0 6281.1 6297.8 6371.7 6064.5 6150.9 6190.9 6192.4 6209.8 4662.6 4760.9 4830.3 4831.4 4836.6 4745.9 4755.8 4762.1 4802.7 4815.8 4716.6 4737.8 4740.9 4751.5 4786.7 4760.9 4778.9 4787.8 4797.1 4800.1 4210.1 4215.6 4215.6 4217.7 4227.6 5843.9 5895.5 5916.0 5917.5 5933.8 5359.8 5555.8 5559.7 5561.5 5584.7 6566.8 6570.6 6579.2 6592.4 6617.5 4551.2 4584.7 4593.7 4594.4 4633.0 6817.5 6846.0 6855.2 6875.0 6885.5 4643.7 4669.0 4733.9 4739.6 4756.5 4770.8 4797.5 4799.3 4801.2 4807.0 5516.8 5518.3 5522.5 5525.2 5555.2 6624.3 6626.3 6631.8 6640.7 6644.4 1654.4 1679.7 1699.9 1702.0 1708.4 1111.0 1116.1 1124.1 1124.2 1136.8 6333.7 6361.2 6403.4 6403.5 6407.7 6732.8 6767.1 6793.2 6795.2 6816.6 6312.4 6325.2 6333.8 6351.6 6379.5 3630.3 3658.0 3663.9 3668.9 3670.9 7196.7 7283.9 7343.5 7355.5 7358.4 6945.5 6996.8 7056.4 7081.0 7084.6 7290.9 7333.3 7335.1 7346.4 7357.4 6771.1 6789.5 6894.6 6906.2 6913.4 6683.3 6783.4 6797.5 6800.0 6809.1 7255.5 7314.2 7337.2 7344.2 7381.5 4547.5 4570.9 4577.8 4613.4 4644.9 6838.8 6839.3 6847.2 6882.8 6893.1 6441.4 6666.9 6697.0 6704.3 6706.4 6637.3 6650.3 6676.4 6678.2 6680.0 6526.1 6527.4 6567.7 6580.5 6591.1 6604.2 6726.3 6729.8 6736.1 6756.6 6534.6 6548.1 6559.2 6573.0 6616.3 00:24:35 INFO - PROCESS | 8459 | 00:24:35 INFO - PROCESS | 8459 | [#5] yui.html Cycles:180 Average:13796.33 Median:48121.78 stddev:16032.47 (33.3%) stddev-sans-first:16047.69 00:24:35 INFO - PROCESS | 8459 | Values: 789.7 801.1 815.6 821.3 910.2 14861.2 14933.6 15004.1 15053.5 15107.1 13369.5 13397.7 13413.3 13427.0 13508.8 775.5 932.7 952.2 952.5 954.2 942.7 945.5 945.6 948.9 954.7 997.7 998.1 1007.7 1009.9 1019.9 1005.0 1005.0 1005.8 1007.0 1009.3 741.4 743.6 745.5 746.2 748.6 14212.6 14333.9 14344.5 14653.6 14763.0 13939.6 14168.7 14228.7 14230.8 14284.9 10784.1 11050.7 11918.4 12005.5 12211.0 3945.2 3950.1 3964.7 3980.1 4028.7 48102.5 48111.3 48281.5 48521.8 48532.5 9581.2 9644.0 9912.1 9972.3 10394.6 19131.1 19213.5 19281.9 19316.3 19445.3 7878.3 8131.8 8143.3 8244.5 8312.2 4378.2 4384.2 4397.4 4421.9 4505.1 3297.3 3354.4 3372.3 3388.0 3404.5 595.9 605.5 611.6 614.1 616.2 570.3 589.5 591.8 592.1 594.1 7763.9 7833.3 7877.7 7999.0 8067.7 580.6 634.6 645.8 646.3 647.8 3664.9 3705.8 3808.8 3855.5 3941.2 56394.7 57110.0 57887.1 58106.4 58135.0 48861.0 50058.0 50432.2 50508.5 51587.5 47157.8 47325.3 47899.3 48132.3 48150.5 7396.1 7486.0 7514.7 7562.4 7597.4 35861.8 35920.5 36732.3 36909.8 37246.4 40961.8 42099.6 43388.0 45986.5 46790.3 9623.7 10066.7 10210.9 10276.3 10310.7 10231.0 10390.2 10393.8 10563.5 10910.9 9900.7 10040.6 10182.7 10241.5 10394.8 9140.0 9157.6 9350.0 9902.5 9950.8 9960.1 10068.4 10247.2 10260.4 10333.9 8835.3 8843.6 8983.4 9015.4 9090.5 8274.3 8930.1 8935.9 9000.6 9105.5 00:24:35 INFO - PROCESS | 8459 | -------- Summary: end -------- 00:24:35 INFO - PROCESS | 8459 | 00:24:36 INFO - TEST-INFO | 8459: exit 0 00:24:36 INFO - TEST-OK | dromaeo_css | took 1109171ms 00:24:36 INFO - TEST-START | kraken 00:24:36 INFO - operating with platform_type : linux_ 00:24:36 INFO - Initialising browser for kraken test... 00:24:36 INFO - TEST-INFO | started process 8700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHjj9t_/profile http://localhost:48581/getInfo.html) 00:24:39 INFO - PROCESS | 8700 | 00:24:39 INFO - PROCESS | 8700 | (process:8774): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:24:40 INFO - PROCESS | 8700 | __metrics Screen width/height:1600/1200 00:24:40 INFO - PROCESS | 8700 | colorDepth:24 00:24:40 INFO - PROCESS | 8700 | Browser inner width/height: 1024/697 00:24:40 INFO - PROCESS | 8700 | __metrics 00:24:40 ERROR - PROCESS | 8700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 00:24:41 INFO - TEST-INFO | 8700: exit 0 00:24:41 INFO - Browser initialized. 00:24:41 INFO - Running cycle 1/1 for kraken test... 00:24:41 INFO - TEST-INFO | started process 8825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHjj9t_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:43 INFO - PROCESS | 8825 | 00:24:43 INFO - PROCESS | 8825 | (process:8894): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:24:53 INFO - PROCESS | 8825 | RSS: Main: 151314432 00:24:53 INFO - PROCESS | 8825 | 00:24:56 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-beat-detection) 00:24:56 INFO - PROCESS | 8825 | RSS: Main: 156000256 00:24:56 INFO - PROCESS | 8825 | 00:24:59 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-dft) 00:24:59 INFO - PROCESS | 8825 | RSS: Main: 155926528 00:24:59 INFO - PROCESS | 8825 | 00:25:02 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-fft) 00:25:03 INFO - PROCESS | 8825 | RSS: Main: 156561408 00:25:03 INFO - PROCESS | 8825 | 00:25:05 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-oscillator) 00:25:06 INFO - PROCESS | 8825 | RSS: Main: 157061120 00:25:06 INFO - PROCESS | 8825 | 00:25:08 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:25:08 INFO - PROCESS | 8825 | RSS: Main: 156659712 00:25:08 INFO - PROCESS | 8825 | 00:25:11 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-darkroom) 00:25:12 INFO - PROCESS | 8825 | RSS: Main: 156934144 00:25:12 INFO - PROCESS | 8825 | 00:25:15 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-desaturate) 00:25:16 INFO - PROCESS | 8825 | RSS: Main: 157106176 00:25:16 INFO - PROCESS | 8825 | 00:25:19 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48581/tests/kraken/driver.html?testName=json-parse-financial) 00:25:19 INFO - PROCESS | 8825 | RSS: Main: 156975104 00:25:19 INFO - PROCESS | 8825 | 00:25:21 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:25:22 INFO - PROCESS | 8825 | RSS: Main: 156758016 00:25:22 INFO - PROCESS | 8825 | 00:25:23 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:25:24 INFO - PROCESS | 8825 | RSS: Main: 156004352 00:25:24 INFO - PROCESS | 8825 | 00:25:26 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:25:27 INFO - PROCESS | 8825 | RSS: Main: 156688384 00:25:27 INFO - PROCESS | 8825 | 00:25:29 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:25:30 INFO - PROCESS | 8825 | RSS: Main: 156798976 00:25:30 INFO - PROCESS | 8825 | 00:25:32 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:25:33 INFO - PROCESS | 8825 | RSS: Main: 157106176 00:25:33 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48581/tests/kraken/driver.html?testName=ai-astar) 00:25:35 INFO - PROCESS | 8825 | RSS: Main: 158953472 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | __start_tp_report 00:25:35 INFO - PROCESS | 8825 | _x_x_mozilla_page_load 00:25:35 INFO - PROCESS | 8825 | _x_x_mozilla_page_load_details 00:25:35 INFO - PROCESS | 8825 | |i|pagename|runs| 00:25:35 INFO - PROCESS | 8825 | |0;ai-astar;114;107;114;113;113;122;112;115;113;110 00:25:35 INFO - PROCESS | 8825 | |1;audio-beat-detection;153;132;154;170;133;159;162;130;167;126 00:25:35 INFO - PROCESS | 8825 | |2;audio-dft;163;167;167;165;166;165;164;165;169;165 00:25:35 INFO - PROCESS | 8825 | |3;audio-fft;76;76;76;167;77;77;73;76;163;75 00:25:35 INFO - PROCESS | 8825 | |4;audio-oscillator;95;95;142;94;94;92;141;96;94;145 00:25:35 INFO - PROCESS | 8825 | |5;imaging-gaussian-blur;117;118;117;119;118;117;118;118;119;119 00:25:35 INFO - PROCESS | 8825 | |6;imaging-darkroom;146;146;146;148;148;147;146;148;149;147 00:25:35 INFO - PROCESS | 8825 | |7;imaging-desaturate;97;96;96;96;97;96;96;96;97;97 00:25:35 INFO - PROCESS | 8825 | |8;json-parse-financial;55;58;56;57;57;59;56;65;56;55 00:25:35 INFO - PROCESS | 8825 | |9;json-stringify-tinderbox;65;66;66;65;66;68;66;65;65;65 00:25:35 INFO - PROCESS | 8825 | |10;stanford-crypto-aes;78;79;81;80;80;79;80;79;87;81 00:25:35 INFO - PROCESS | 8825 | |11;stanford-crypto-ccm;121;115;116;124;122;121;119;119;115;128 00:25:35 INFO - PROCESS | 8825 | |12;stanford-crypto-pbkdf2;139;149;145;148;145;144;148;149;147;137 00:25:35 INFO - PROCESS | 8825 | |13;stanford-crypto-sha256-iterative;71;68;69;70;75;77;70;66;69;71 00:25:35 INFO - PROCESS | 8825 | __end_tp_report 00:25:35 INFO - PROCESS | 8825 | __start_cc_report 00:25:35 INFO - PROCESS | 8825 | _x_x_mozilla_cycle_collect,873 00:25:35 INFO - PROCESS | 8825 | __end_cc_report 00:25:35 INFO - PROCESS | 8825 | __startTimestamp1461223535294__endTimestamp 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | ------- Summary: start ------- 00:25:35 INFO - PROCESS | 8825 | Number of tests: 14 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:3.83 (3.4%) stddev-sans-first:4.06 00:25:35 INFO - PROCESS | 8825 | Values: 114.0 107.0 114.0 113.0 113.0 122.0 112.0 115.0 113.0 110.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:156.50 stddev:16.69 (10.7%) stddev-sans-first:17.63 00:25:35 INFO - PROCESS | 8825 | Values: 153.0 132.0 154.0 170.0 133.0 159.0 162.0 130.0 167.0 126.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:1.71 (1.0%) stddev-sans-first:1.54 00:25:35 INFO - PROCESS | 8825 | Values: 163.0 167.0 167.0 165.0 166.0 165.0 164.0 165.0 169.0 165.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.66 (49.6%) stddev-sans-first:39.40 00:25:35 INFO - PROCESS | 8825 | Values: 76.0 76.0 76.0 167.0 77.0 77.0 73.0 76.0 163.0 75.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:94.00 stddev:23.41 (24.9%) stddev-sans-first:24.30 00:25:35 INFO - PROCESS | 8825 | Values: 95.0 95.0 142.0 94.0 94.0 92.0 141.0 96.0 94.0 145.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 00:25:35 INFO - PROCESS | 8825 | Values: 117.0 118.0 117.0 119.0 118.0 117.0 118.0 118.0 119.0 119.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 00:25:35 INFO - PROCESS | 8825 | Values: 146.0 146.0 146.0 148.0 148.0 147.0 146.0 148.0 149.0 147.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 00:25:35 INFO - PROCESS | 8825 | Values: 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 97.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.95 (5.2%) stddev-sans-first:3.00 00:25:35 INFO - PROCESS | 8825 | Values: 55.0 58.0 56.0 57.0 57.0 59.0 56.0 65.0 56.0 55.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 00:25:35 INFO - PROCESS | 8825 | Values: 65.0 66.0 66.0 65.0 66.0 68.0 66.0 65.0 65.0 65.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.50 (3.1%) stddev-sans-first:2.50 00:25:35 INFO - PROCESS | 8825 | Values: 78.0 79.0 81.0 80.0 80.0 79.0 80.0 79.0 87.0 81.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:121.00 stddev:4.14 (3.4%) stddev-sans-first:4.37 00:25:35 INFO - PROCESS | 8825 | Values: 121.0 115.0 116.0 124.0 122.0 121.0 119.0 119.0 115.0 128.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:147.50 stddev:4.15 (2.8%) stddev-sans-first:3.77 00:25:35 INFO - PROCESS | 8825 | Values: 139.0 149.0 145.0 148.0 145.0 144.0 148.0 149.0 147.0 137.0 00:25:35 INFO - PROCESS | 8825 | 00:25:35 INFO - PROCESS | 8825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:3.24 (4.6%) stddev-sans-first:3.43 00:25:35 INFO - PROCESS | 8825 | Values: 71.0 68.0 69.0 70.0 75.0 77.0 70.0 66.0 69.0 71.0 00:25:35 INFO - PROCESS | 8825 | -------- Summary: end -------- 00:25:35 INFO - PROCESS | 8825 | 00:25:36 INFO - TEST-INFO | 8825: exit 0 00:25:36 INFO - TEST-OK | kraken | took 59965ms 00:25:36 INFO - SUITE-END | took 1169s 00:25:36 INFO - Completed test suite (00:19:29) 00:25:36 INFO - javascript benchmark 00:25:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3241.529978153168, 3361.966380336196, 3370.5618269624947, 3397.116749645093, 3417.8632854685816, 5414.431484694104, 5434.782608695652, 5442.809501667442, 5459.344878614572, 5491.670499770012, 5449.3188351456065, 5451.127819548873, 5459.290292262001, 5470.972645136779, 5481.972590137054, 4902.901941961159, 5015.172496538067, 5025.14572522672, 5073.771680274396, 5111.437741848394, 4856.980034192824, 4992.750362481879, 5012.248162775594, 5016.774245158977, 5176.870578235536, 4967.279744437054, 4977.900441991176, 5024.397072351305, 5039.647224694273, 5057.5701065409485, 5013.448520662724, 5018.548330650241, 5020.2218656108, 5031.0, 5051.318072060299, 4752.4297084349755, 4906.0, 4957.281194226853, 4962.503749625044, 5014.272930425104, 5166.689998600096, 5168.095583272912, 5185.55922746567, 5219.112750832368, 5269.446708095671, 5784.1902133701315, 5837.562182836305, 5843.590948633598, 5855.795047173328, 5861.589688721791, 5864.0, 5894.528437724972, 5914.260717410324, 5980.671063091529, 6000.0999850022845, 5412.675239485643, 5454.263674403905, 5465.945340546623, 5471.808486702986, 5481.342238931354, 5849.239598852122, 5925.0, 5936.584439089309, 5936.9406305937255, 5939.970300148471, 5763.818417224459, 5776.191333213354, 5803.709814509258, 5809.767609295581, 5866.794662186803, 5786.681732504669, 5788.131780232999, 5794.449527294901, 5800.158976948319, 5800.477956983892, 5633.605647604629, 5744.0, 5749.338826035059, 5752.856178595485, 5789.942100579025, 5723.313202415737, 5725.799597014085, 5757.165211044375, 5760.481556659921, 5822.621529600562, 4421.911561768747, 4434.157510073076, 4438.356438316426, 4453.532379100213, 4484.372187893698, 3952.960470395317, 3997.240524300432, 4029.6373326400767, 4034.6772258219858, 4042.939355909664, 5468.425815289417, 5547.639403438763, 5645.237892884408, 5652.519535839418, 5653.773849046074, 5793.652380857162, 5851.9173952818865, 5857.297124345106, 5861.17943487912, 5885.61743486672, 5520.53075488588, 5530.308711411074, 5578.246936663499, 5607.383187849333, 5624.072028115397, 5067.569256613156, 5072.923906141411, 5075.289459475676, 5092.592592592584, 5096.592272618182, 6153.84615384619, 6208.068789681584, 6237.220347456568, 6244.843878903063, 6250.874982500324, 5698.2592263005545, 5867.853303667443, 5922.7334769936315, 5978.551608629283, 5978.790742323998, 6201.086685608785, 6230.844228894314, 6232.470240029648, 6249.312575616769, 6261.96869015652, 5795.449432304093, 5799.0, 5806.583317151284, 5863.0, 5892.587518873637, 5655.519280861173, 5823.941760582509, 5883.0, 5892.823215303548, 5915.231019967377, 5738.225339579103, 5775.306963164279, 5776.277965254343, 5785.3636100028125, 5786.797462088806, 5583.385827559046, 5680.289963754531, 5749.597528172988, 5778.94221057784, 5783.132530120515, 5568.49883510486, 5625.043742563856, 5661.575381846295, 5671.404502527175, 5695.772169113189, 5721.22763426932, 5740.339860916049, 5752.942470575241, 5755.251817263729, 5758.827235182951, 5479.945200547943, 5558.694271814928, 5634.549236061023, 5643.661380317194, 5709.685967271674], "unit": "score", "name": "dojo.html", "value": 5408.122809411176}, {"lowerIsBetter": false, "replicates": [514.93820741511, 564.6188822544781, 564.652738565782, 585.2479563760567, 592.8221533539939, 40473.0, 40947.18105637885, 41017.589824101786, 41158.17683646325, 41279.79360103199, 45295.773521132345, 45838.31242531356, 46052.0, 46155.769221153845, 46218.0, 8800.691975780848, 8975.192232699055, 9015.729528114167, 9030.954845225764, 9081.59132839024, 8706.0, 8957.596908139118, 8962.73111806647, 8990.550472476383, 8994.595243214038, 9141.131592498701, 9156.175944165025, 9246.214071803905, 9258.166764991149, 9276.860847087299, 9157.496337701425, 9166.724998250063, 9192.172704456563, 9200.769980750501, 9211.078892110801, 8968.865467018, 9079.68221112258, 9135.406198597137, 9167.174954254082, 9209.309301802392, 37141.442878356844, 37190.4421433676, 37455.43816842749, 37516.249675006344, 37552.24895502075, 3715.5912849586525, 3782.659560639528, 3808.6762625176893, 4320.179165958458, 4341.45731783527, 33444.66555334464, 33636.32727345464, 33668.0, 33742.83128584366, 33869.49195762065, 4098.344264917599, 4178.101708132735, 4192.24539582875, 4263.296556068245, 4319.200947824663, 298020.0, 299850.0, 300309.0, 300436.9999999978, 300850.0, 46686.5331346689, 46887.1245150197, 46966.53033469622, 46998.0, 68824.0, 45548.54451455509, 45713.77143114263, 45746.0, 45750.77124614356, 45837.77081114573, 16976.405825796286, 17283.481495555152, 17287.049212293445, 17338.13309334528, 17364.91317543404, 13703.657408564866, 13844.30778461073, 13845.446182152602, 13853.376598053112, 13950.23273719955, 15838.574528292509, 15947.36210551565, 15979.201039947957, 15982.280797364147, 16056.678866422606, 6006.939930600725, 6245.125682404467, 6248.156498872685, 6275.121482992385, 6282.308946015934, 1084.6203828660064, 1087.3856271206744, 1094.179365475893, 1135.5287555664306, 1150.2810743285447, 30573.541396879064, 30646.38707225843, 30656.147008888354, 31412.0, 31600.73597056092, 1128.1426116151783, 1162.7674465107013, 1192.9919218260557, 1197.4910662968205, 1226.7546490701716, 15707.764383534257, 15893.284802183929, 16173.514794556182, 16254.349826007065, 16374.426895058854, 335499.0, 528403.0, 531489.0, 536420.0, 767864.0, 64890.0, 65833.0, 66001.66999164973, 66083.33916660772, 66113.33886661072, 1468.5961360625913, 1475.4172102019643, 1480.208088672555, 1495.2374289112631, 1502.8346881842988, 31706.841465792524, 32260.35479290448, 32803.0, 32857.0, 32857.67142328642, 54475.72762136164, 55453.0, 55472.0, 55482.44517554934, 55654.44345556493, 317707.0, 321518.0, 323867.0, 324324.0, 324611.0, 47649.0, 47999.0, 48226.0, 49533.0, 49776.50223497864, 51148.23277650764, 51155.0, 51790.482095178566, 52888.735556321975, 53017.0, 43320.78339608282, 43346.78326608347, 44058.55941440545, 44610.330845038, 44830.103397931205, 43839.56160438355, 44355.77822110998, 44462.333065003404, 44474.0, 44863.0, 42134.36798448087, 42945.570544294154, 42986.57013429826, 43151.784241078596, 43457.56542434662, 35855.82072089623, 35910.64089359073, 36732.26535469222, 37031.62968370282, 37149.25701485901, 28052.158435246976, 28500.42999140047, 28596.142115736562, 28653.713462865104, 28682.85658571777], "unit": "score", "name": "ext.html", "value": 20222.971940960833}, {"lowerIsBetter": false, "replicates": [371.22043708212755, 383.57614835606654, 385.07197653654697, 386.7157639135236, 390.8885967499263, 18626.254949802027, 18639.25442982279, 19448.805511944876, 19714.112864921077, 20444.59110817783, 17526.123693815323, 17565.82434175658, 17750.733738993895, 17803.198856051476, 17927.73108403375, 5166.689998600096, 5433.402325744165, 5464.098423760075, 5469.535089517396, 5806.738696758656, 5760.942390576103, 5811.244538210027, 5815.73829177688, 5842.707864606774, 5855.648661080328, 5424.972875135619, 5512.586556008296, 5815.360310365878, 5827.184194212814, 5877.235959325281, 5353.304070470834, 5407.918416316733, 5412.161115027177, 5440.700761458118, 5442.455754424565, 5225.346831646044, 5253.55344795689, 5256.185291279858, 5264.210368444726, 5317.361916569997, 13911.30443477822, 14038.0, 14214.0, 14238.501652442219, 14245.572632821031, 2281.840271181018, 2295.4490922178725, 2386.7255265644326, 2408.2895545813853, 2934.0611004478574, 10164.44095574743, 10433.269671123024, 10461.476926153739, 10494.79010419795, 10498.737531561696, 1868.822461866134, 1957.4323446200585, 1990.790966948464, 2015.606956643455, 2060.577581595769, 65125.0, 68584.3141568583, 68721.65639171822, 69285.65357173182, 69383.0, 10474.528646210938, 10495.422751748727, 10735.83896241557, 10939.28894621847, 11377.0, 13503.324833758274, 14238.074525155831, 14869.628259293388, 15102.093874367572, 15139.318730657147, 8067.878981815277, 8216.876746848802, 8447.155284471626, 8499.830003399897, 8506.957465212634, 8058.677652893936, 8061.4760040597175, 8154.347652187811, 8197.590120493951, 8294.958525207336, 4647.279671650899, 4652.95347046532, 4677.579017888338, 4794.7362895040405, 4802.567768900815, 1952.541152829084, 1955.1495099631422, 1971.0, 2002.6895831146196, 2008.447676888838, 985.9063388978036, 1010.8989101089833, 1029.6447725534679, 1039.6413237433226, 1061.6496556136456, 17495.912520437316, 17525.757734818846, 17806.554836129202, 18146.45560633183, 18492.167852446404, 979.4123525884555, 1014.3171311880183, 1083.34999000599, 1092.093562343253, 1095.8465814785936, 10099.277483308366, 10257.897421025695, 10262.43556604394, 10294.794104117876, 10443.425611591436, 401939.0, 405288.0, 409157.0, 409744.0, 424978.0, 68021.3197868015, 71173.64413177902, 72141.2785872145, 72694.63652681808, 74030.0, 1022.7852151048214, 1067.2369255981855, 1068.2842495528014, 1083.8536797532233, 1084.6908631040117, 16163.67672646564, 16391.016539007698, 16503.422380216634, 16505.66988660196, 16607.0, 34470.65529344675, 35825.46261806127, 36346.8182659085, 36536.634633653324, 36858.8157059213, 48788.0, 48966.26550601815, 49168.01663966629, 49551.50448495469, 50097.49902500928, 8357.623906924082, 8464.449810762528, 8667.089955554577, 8798.780030499289, 8806.471611703319, 12681.93659031699, 13185.40665670028, 13263.071584988958, 13385.598432047054, 13589.388477518338, 11962.76074478523, 11974.700632484257, 12099.697507562381, 12175.269483830643, 12200.572979945659, 12054.51781928713, 12085.154039217523, 12149.616764432514, 12182.390880455765, 12291.692707682021, 12202.206856554296, 12373.443195056065, 12473.93763031179, 12556.246625202517, 12763.936180319039, 8293.21214484623, 8377.49735015901, 8504.489730616182, 8642.56787160652, 8742.082081381363, 8639.784005399664, 11252.943735281271, 11526.82709759371, 11689.415529223335, 11717.707057323634], "unit": "score", "name": "jquery.html", "value": 8839.129825313057}, {"lowerIsBetter": false, "replicates": [1583.3349993002937, 1585.1361008250503, 1846.4645252876667, 1938.932137375192, 1984.474114359694, 7514.774556763306, 8342.0, 8506.319494440446, 8710.651573937042, 8734.170253825885, 8393.16068393162, 8404.0, 8480.787980300496, 8494.150584941503, 8494.660213591449, 2429.8177636677233, 2459.7540245975347, 2464.5194187133516, 2464.7658472445087, 2474.0, 2398.9444644356427, 2420.080369459603, 2441.2554170977846, 2445.1808644104244, 2445.4742230420457, 2422.4065104049446, 2429.137656132074, 2450.901963921441, 2467.3214865911837, 2474.1958863369387, 2409.6024156014414, 2412.0954642009247, 2446.1805295226122, 2448.3634255093625, 2458.2625212436287, 2402.6636270922086, 2414.9154779582805, 2431.805455563551, 2433.9634905476432, 2436.658867758515, 8594.226519613265, 8603.483790972561, 8653.480791152488, 8687.565621718888, 8692.174243446863, 5261.973690131563, 5372.382176049765, 5380.704061276629, 5387.0, 5390.8921821563345, 3293.9835300823584, 3335.7664963452567, 3357.8153201573905, 3386.305807309496, 3389.084947064279, 1094.9014588687057, 1097.3470784882982, 1105.6517197082974, 1107.2747350485445, 1107.6067995861433, 12276.754464910651, 12300.876991230063, 12307.200031997982, 12331.075169362333, 12368.81446778299, 4533.342665313577, 4596.264597664424, 4612.538746125428, 4619.3994780678295, 4640.744759038285, 10244.948775256076, 10293.53679084443, 10334.328268662513, 10343.94828025855, 10394.844077338847, 5235.554977826928, 5325.627206095536, 5331.70675612845, 5352.705601191894, 5371.194320851825, 4166.58334166587, 4680.719156850531, 4772.952270477251, 4793.0413917216, 4810.302506136591, 3857.0, 3962.3660214365564, 3978.124812541294, 3993.0, 4045.7572545647354, 1273.6882558156915, 1288.2592509306999, 1297.47452281826, 1302.2316833068535, 1302.5115581656878, 1175.9000484958874, 1198.0415667465993, 1319.168923578159, 1443.0, 1470.264867566217, 8169.223923727236, 8173.795655108551, 8214.753557393287, 8262.049864265566, 8273.46222495548, 514.9639525233198, 515.9045576568346, 524.8976449592293, 529.3912001198653, 529.4943329120681, 6008.429199226067, 6113.052476866093, 6145.5698101133385, 6156.846078848064, 6166.136740856284, 10315.638952636771, 10671.0, 10674.466276686135, 10762.515686794113, 10785.0, 9762.853557196506, 10404.219683523766, 10543.894561054445, 10577.84133238002, 10611.257211995086, 8073.434859559775, 8082.919170808216, 8131.512109273463, 8133.430659853753, 8177.100518942912, 7912.0505539335645, 7988.720394786154, 8027.117017127995, 8250.917490825255, 8295.170482951657, 9470.573824178065, 9525.0, 9590.904090959, 9632.133108020313, 9727.562259698188, 9746.951265243628, 9750.317477776487, 9884.950575247078, 9962.601495940082, 10071.093601575893, 6747.932520674731, 7136.785896423115, 7334.046573945353, 7550.169481356937, 7717.382609391123, 8059.476134051268, 8107.594620269081, 8122.431429799857, 8141.14517975604, 8172.223638754309, 7198.388137008413, 7328.303811137934, 7579.772606821804, 7585.127710313384, 7672.117706463828, 7149.428045756223, 7229.09636295463, 7287.927120728725, 7291.125064992235, 7345.632718363953, 7732.613369331623, 7785.883211751715, 7804.414668899742, 7814.101378341564, 7822.491538050009, 6662.133922590032, 6715.26132125456, 6733.427658648874, 6735.090762746966, 6941.757038503628, 7073.469489788389, 7080.079589653312, 7098.219195888345, 7100.964495177491, 7116.359527642537], "unit": "score", "name": "mootools.html", "value": 4823.55489243909}, {"lowerIsBetter": false, "replicates": [366.5949126215532, 368.33331669677875, 370.54608105071276, 371.2463698691657, 376.1142509390386, 6243.906341404882, 6269.968650156754, 6281.089242059898, 6297.842553936154, 6371.713272902719, 6064.484518815906, 6150.907736383958, 6190.907136392958, 6192.380761923817, 6209.813705588839, 4662.557057079589, 4760.90478190436, 4830.3237546743485, 4831.396075490564, 4836.564709176182, 4745.857624271277, 4755.809767609291, 4762.119007983534, 4802.711837289757, 4815.831445899395, 4716.599089077433, 4737.834175803848, 4740.857774266778, 4751.524847515256, 4786.736729479877, 4760.9049918518585, 4778.928316075262, 4787.832425865078, 4797.088553174885, 4800.135975524404, 4210.115875666083, 4215.59951804578, 4215.641670458015, 4217.746935183868, 4227.577242275778, 5843.883122337572, 5895.498882594985, 5916.0, 5917.497012753921, 5933.792317268875, 5359.785608575652, 5555.833325000256, 5559.722013899289, 5561.5272701820395, 5584.748686309126, 6566.80299591013, 6570.63861487618, 6579.17760279965, 6592.373724496165, 6617.503687223478, 4551.249043907751, 4584.701994370355, 4593.701409408412, 4594.402727645418, 4632.953670463319, 6817.488688348394, 6846.0, 6855.211650660138, 6875.0, 6885.483588730865, 4643.721376717408, 4668.976655116703, 4733.928991065137, 4739.578126562086, 4756.500567440438, 4770.76146192689, 4797.472278049412, 4799.3041009053495, 4801.207800712843, 4807.014562014779, 5516.7517461714315, 5518.310211223597, 5522.530584900248, 5525.171224316305, 5555.166724991283, 6624.304448032984, 6626.337366263335, 6631.834204144935, 6640.701168447432, 6644.4020038196795, 1654.4126834973652, 1679.706051440993, 1699.923503442348, 1701.9829801701824, 1708.4105983435695, 1110.9888901111046, 1116.0680831505622, 1124.0894875151155, 1124.2242852431796, 1136.778328225988, 6333.651649159248, 6361.236651601837, 6403.391677790602, 6403.519736019817, 6407.711652975628, 6732.764353247613, 6767.052612634235, 6793.218779840382, 6795.218549866829, 6816.556923799937, 6312.368763123743, 6325.177726895567, 6333.809985700436, 6351.55539112267, 6379.457746091634, 3630.3102410541915, 3657.9634203658156, 3663.9267214656093, 3668.944965825515, 3670.908227294339, 7196.748113815991, 7283.890741638879, 7343.48595598303, 7355.521891077063, 7358.448116391185, 6945.548539344926, 6996.825079372955, 7056.364927156478, 7081.0, 7084.610346430995, 7290.927090729025, 7333.339999400079, 7335.119785625652, 7346.412287017026, 7357.411407087528, 6771.119754431892, 6789.456843452611, 6894.620795856276, 6906.205786334636, 6913.3777959983845, 6683.264840867598, 6783.423409010092, 6797.524173308018, 6800.013997970168, 6809.114815074008, 7255.52839065459, 7314.232005639331, 7337.229590893093, 7344.15542212631, 7381.483296169216, 4547.499775024811, 4570.862874113782, 4577.816887324603, 4613.400257966443, 4644.883877903079, 6838.794836154724, 6839.281875403011, 6847.21257055445, 6882.827929301808, 6893.103896493424, 6441.355864413521, 6666.866662666816, 6697.0, 6704.262531121671, 6706.362895524917, 6637.269900311058, 6650.334966503311, 6676.432503237279, 6678.23200331968, 6680.0, 6526.053722210348, 6527.412532872065, 6567.671616419256, 6580.539362244597, 6591.110200122922, 6604.24051234095, 6726.293739157318, 6729.798106056826, 6736.124303840469, 6756.628385438651, 6534.640594767143, 6548.116004339353, 6559.212894452506, 6572.967135164294, 6616.305287944697], "unit": "score", "name": "prototype.html", "value": 5024.473875221357}, {"lowerIsBetter": false, "replicates": [789.6604460082162, 801.118769353711, 815.6044318505527, 821.3183058061808, 910.1808372464782, 14861.182634955074, 14933.5519934402, 15004.099754014767, 15053.47312844052, 15107.093574385532, 13369.465221391132, 13397.665058373546, 13413.262270575115, 13427.0, 13508.797368039463, 775.4998026273065, 932.7388331267256, 952.2334520710825, 952.5094576293214, 954.1746389373211, 942.6653537994016, 945.5036106044347, 945.5981207986613, 948.8908775490838, 954.7231302922145, 997.7006897930592, 998.1116806042628, 1007.6775431861807, 1009.9242556808232, 1019.8776146862386, 1004.9949750251238, 1005.0301459091938, 1005.7938122684868, 1006.9949650251775, 1009.2783659683362, 741.3587247031332, 743.5612988336907, 745.5191401545973, 746.2015643261713, 748.5733132114697, 14212.644683882882, 14333.856661433356, 14344.49794257196, 14653.6336591585, 14763.0, 13939.581812545639, 14168.716625667428, 14228.715425691531, 14230.786538201935, 14284.928575357057, 10784.13726901846, 11050.723731906686, 11918.404079795975, 12005.519779208822, 12211.0, 3945.171513982067, 3950.071733142709, 3964.682825373963, 3980.144268982183, 4028.7179897407195, 48102.518974810155, 48111.278330825065, 48281.51718482805, 48521.75739121282, 48532.514674853155, 9581.233501319877, 9643.951780241054, 9912.05835445646, 9972.252081093948, 10394.584216631401, 19131.13909874059, 19213.519662008563, 19281.903590482238, 19316.32392866243, 19445.31941382045, 7878.330341920886, 8131.83736325282, 8143.267105960492, 8244.54654993969, 8312.21034001769, 4378.16814805186, 4384.167008268419, 4397.428334316583, 4421.9336709949375, 4505.05393867285, 3297.258116923673, 3354.3626710924846, 3372.274960883373, 3388.034410193083, 3404.472306792451, 595.9016762234182, 605.5337390209514, 611.6146827498648, 614.0942110387233, 616.1958643969663, 570.2586637371401, 589.5018709190726, 591.8461200088008, 592.1059200607115, 594.1266338482424, 7763.92236077632, 7833.255840695125, 7877.7242796503, 7999.0, 8067.677292908218, 580.6312991250586, 634.6002018728171, 645.8030300758314, 646.3052218864739, 647.821848991531, 3664.926701465956, 3705.81470926458, 3808.7524310919703, 3855.4602355670227, 3941.1526521797377, 56394.7180264096, 57110.0, 57887.13169302464, 58106.4189358101, 58135.0, 48861.0, 50058.0, 50432.243516347284, 50508.49491505112, 51587.48412515827, 47157.76421117873, 47325.29012064822, 47899.281510777364, 48132.27801582909, 48150.518494814605, 7396.149442814145, 7486.0, 7514.736984205527, 7562.395008399425, 7597.430192735677, 35861.820690897424, 35920.4611930816, 36732.26535469329, 36909.81545092257, 37246.44130338101, 40961.795191023855, 42099.57900420957, 43388.0, 45986.54013459956, 46790.298145528526, 9623.711288661352, 10066.69799906004, 10210.948945255226, 10276.280660353703, 10310.690679279634, 10231.0, 10390.220733445172, 10393.792124157324, 10563.524641391003, 10910.890891090987, 9900.702978910644, 10040.598376064876, 10182.687348752048, 10241.539130739284, 10394.792104158027, 9140.0, 9157.587908544265, 9350.018248084125, 9902.451832805757, 9950.751231219278, 9960.103590676874, 10068.446235456828, 10247.180225582084, 10260.43567603759, 10333.948330258301, 8835.293176545989, 8843.557822108998, 8983.416077955173, 9015.368924175245, 9090.545472726206, 8274.29668478186, 8930.106989301277, 8935.865962010444, 9000.63997440095, 9105.544722763967], "unit": "score", "name": "yui.html", "value": 6403.160301085401}], "name": "dromaeo_css", "value": 7289.512643382001}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 114.0, 113.0, 113.0, 122.0, 112.0, 115.0, 113.0, 110.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 154.0, 170.0, 133.0, 159.0, 162.0, 130.0, 167.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [163.0, 167.0, 167.0, 165.0, 166.0, 165.0, 164.0, 165.0, 169.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.6}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 76.0, 167.0, 77.0, 77.0, 73.0, 76.0, 163.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 142.0, 94.0, 94.0, 92.0, 141.0, 96.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 119.0, 118.0, 117.0, 118.0, 118.0, 119.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 148.0, 148.0, 147.0, 146.0, 148.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 56.0, 57.0, 57.0, 59.0, 56.0, 65.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 68.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 81.0, 80.0, 80.0, 79.0, 80.0, 79.0, 87.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.4}, {"lowerIsBetter": true, "replicates": [121.0, 115.0, 116.0, 124.0, 122.0, 121.0, 119.0, 119.0, 115.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [139.0, 149.0, 145.0, 148.0, 145.0, 144.0, 148.0, 149.0, 147.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 69.0, 70.0, 75.0, 77.0, 70.0, 66.0, 69.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1530.6}]} 00:25:36 INFO - Return code: 0 00:25:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:25:36 ERROR - # TBPL SUCCESS # 00:25:36 INFO - Running post-action listener: _resource_record_post_action 00:25:36 INFO - Running post-run listener: _resource_record_post_run 00:25:37 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 500830208; Read time: 0; Write time: 535500 00:25:37 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245133312; Read time: 0; Write time: 361696 00:25:37 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 255635456; Read time: 0; Write time: 173776 00:25:37 INFO - Running post-run listener: _upload_blobber_files 00:25:37 INFO - Blob upload gear active. 00:25:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:25:37 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 00:25:37 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'] 00:25:37 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 00:25:38 INFO - (blobuploader) - INFO - Open directory for files ... 00:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:39 INFO - (blobuploader) - INFO - Done attempting. 00:25:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:25:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:39 INFO - (blobuploader) - INFO - Done attempting. 00:25:39 INFO - (blobuploader) - INFO - Iteration through files over. 00:25:39 INFO - Return code: 0 00:25:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:25:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:25:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a8c7651159bded20650683fdc51605a49591144f29b18ac0f8867f046764b97c81a6c31ba79635c1d56113574bf49031fd55d51ac270004a55a230118bba571", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5711c58758ef5405f81e3c10ade0e9f27e830dd678a0a857b939e01e813f273aa1cadf17976f320b39fe063e1214213d9241cf65ba53df8d995fe96dc7f5044"} 00:25:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:25:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:25:39 INFO - Contents: 00:25:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a8c7651159bded20650683fdc51605a49591144f29b18ac0f8867f046764b97c81a6c31ba79635c1d56113574bf49031fd55d51ac270004a55a230118bba571", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5711c58758ef5405f81e3c10ade0e9f27e830dd678a0a857b939e01e813f273aa1cadf17976f320b39fe063e1214213d9241cf65ba53df8d995fe96dc7f5044"} 00:25:39 INFO - Running post-run listener: copy_logs_to_upload_dir 00:25:39 INFO - Copying logs to upload dir... 00:25:39 INFO - mkdir: /builds/slave/test/build/upload/logs 00:25:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.884890 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-21 00:25:39.385946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 00:25:39.393699) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693 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/1a8c7651159bded20650683fdc51605a49591144f29b18ac0f8867f046764b97c81a6c31ba79635c1d56113574bf49031fd55d51ac270004a55a230118bba571", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5711c58758ef5405f81e3c10ade0e9f27e830dd678a0a857b939e01e813f273aa1cadf17976f320b39fe063e1214213d9241cf65ba53df8d995fe96dc7f5044"} build_url:https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/dPxvAyBNSZKq5UxI9Xsfjg/artifacts/public/build/firefox-47.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/1a8c7651159bded20650683fdc51605a49591144f29b18ac0f8867f046764b97c81a6c31ba79635c1d56113574bf49031fd55d51ac270004a55a230118bba571", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5711c58758ef5405f81e3c10ade0e9f27e830dd678a0a857b939e01e813f273aa1cadf17976f320b39fe063e1214213d9241cf65ba53df8d995fe96dc7f5044"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 00:25:39.428370) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 00:25:39.431977) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461222213.639562-785661693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 00:25:39.723285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 00:25:39.723626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 00:25:39.723998) ========= ========= Total master_lag: 0.75 =========