builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1460678543.14 results: success (0) buildid: 20160414143005 builduid: f2a95d52ccea4ea4ad253917daaefb4f revision: 3e85a84c7d68632e1098cc9374787dc8f54ce24f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.142926) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.143951) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.144678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.162441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.163155) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 17:02:23-- 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% 40.6M=0s 2016-04-14 17:02:23 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110161 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.293771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.294771) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019071 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.346525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.346898) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e85a84c7d68632e1098cc9374787dc8f54ce24f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3e85a84c7d68632e1098cc9374787dc8f54ce24f --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=edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 17:02:23,349 truncating revision to first 12 chars 2016-04-14 17:02:23,349 Setting DEBUG logging. 2016-04-14 17:02:23,349 attempt 1/10 2016-04-14 17:02:23,349 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e85a84c7d68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 17:02:23,610 unpacking tar archive at: fx-team-3e85a84c7d68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566414 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.926928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.927313) ========= script_repo_revision: 3e85a84c7d68632e1098cc9374787dc8f54ce24f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.928336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.928645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:23.938510) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-14 17:02:23.938824) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:02:24 INFO - MultiFileLogger online at 20160414 17:02:24 in /builds/slave/test 17:02:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:02:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:02:24 INFO - {'append_to_log': False, 17:02:24 INFO - 'base_work_dir': '/builds/slave/test', 17:02:24 INFO - 'blob_upload_branch': 'Fx-Team', 17:02:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:02:24 INFO - 'branch': 'Fx-Team', 17:02:24 INFO - 'buildbot_json_path': 'buildprops.json', 17:02:24 INFO - 'config_files': ('talos/linux_config.py',), 17:02:24 INFO - 'default_actions': ('clobber', 17:02:24 INFO - 'read-buildbot-config', 17:02:24 INFO - 'download-and-extract', 17:02:24 INFO - 'populate-webroot', 17:02:24 INFO - 'create-virtualenv', 17:02:24 INFO - 'install', 17:02:24 INFO - 'run-tests'), 17:02:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:02:24 INFO - 'download_minidump_stackwalk': True, 17:02:24 INFO - 'download_symbols': 'ondemand', 17:02:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:02:24 INFO - 'tooltool.py': '/tools/tooltool.py', 17:02:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:02:24 INFO - '/tools/misc-python/virtualenv.py')}, 17:02:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:02:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:02:24 INFO - 'installer_path': 'installer.exe', 17:02:24 INFO - 'log_level': 'info', 17:02:24 INFO - 'log_name': 'talos', 17:02:24 INFO - 'log_to_console': True, 17:02:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:02:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:02:24 INFO - 'opt_config_files': (), 17:02:24 INFO - 'pip_index': False, 17:02:24 INFO - 'sps_profile': False, 17:02:24 INFO - 'sps_profile_interval': 0, 17:02:24 INFO - 'suite': 'dromaeojs-e10s', 17:02:24 INFO - 'system_bits': '32', 17:02:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:02:24 INFO - 'title': 'talos-linux64-ix-033', 17:02:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:02:24 INFO - 'use_talos_json': True, 17:02:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:02:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:02:24 INFO - 'work_dir': 'build'} 17:02:24 INFO - ##### 17:02:24 INFO - ##### Running clobber step. 17:02:24 INFO - ##### 17:02:24 INFO - Running pre-action listener: _resource_record_pre_action 17:02:24 INFO - Running main action method: clobber 17:02:24 INFO - rmtree: /builds/slave/test/build 17:02:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:02:24 INFO - Running post-action listener: _resource_record_post_action 17:02:24 INFO - ##### 17:02:24 INFO - ##### Running read-buildbot-config step. 17:02:24 INFO - ##### 17:02:24 INFO - Running pre-action listener: _resource_record_pre_action 17:02:24 INFO - Running main action method: read_buildbot_config 17:02:24 INFO - Using buildbot properties: 17:02:24 INFO - { 17:02:24 INFO - "project": "", 17:02:24 INFO - "product": "firefox", 17:02:24 INFO - "script_repo_revision": "production", 17:02:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:02:24 INFO - "repository": "", 17:02:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:02:24 INFO - "buildid": "20160414143005", 17:02:24 INFO - "pgo_build": "True", 17:02:24 INFO - "basedir": "/builds/slave/test", 17:02:24 INFO - "buildnumber": 389, 17:02:24 INFO - "slavename": "talos-linux64-ix-033", 17:02:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:02:24 INFO - "platform": "ubuntu64_hw", 17:02:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:02:24 INFO - "branch": "fx-team", 17:02:24 INFO - "repo_path": "integration/fx-team", 17:02:24 INFO - "revision": "3e85a84c7d68632e1098cc9374787dc8f54ce24f", 17:02:24 INFO - "stage_platform": "linux64-pgo", 17:02:24 INFO - "builduid": "f2a95d52ccea4ea4ad253917daaefb4f", 17:02:24 INFO - "slavebuilddir": "test" 17:02:24 INFO - } 17:02:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:02:24 INFO - Running post-action listener: _resource_record_post_action 17:02:24 INFO - ##### 17:02:24 INFO - ##### Running download-and-extract step. 17:02:24 INFO - ##### 17:02:24 INFO - Running pre-action listener: _resource_record_pre_action 17:02:24 INFO - Running main action method: download_and_extract 17:02:24 INFO - mkdir: /builds/slave/test/build/tests 17:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:24 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:02:26 INFO - Downloaded 1361 bytes. 17:02:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:02:26 INFO - Using the following test package requirements: 17:02:26 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:02:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:02:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:26 INFO - u'jsshell-linux-x86_64.zip'], 17:02:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:02:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:02:26 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:02:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:02:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:02:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:26 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:02:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:02:38 INFO - Downloaded 23774857 bytes. 17:02:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:02:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:02:39 INFO - Return code: 0 17:02:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:39 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:02:41 INFO - Downloaded 23774857 bytes. 17:02:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:02:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:02:42 INFO - Return code: 0 17:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:42 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:02:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:02:43 INFO - Downloaded 10841076 bytes. 17:02:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:02:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:02:43 INFO - Return code: 0 17:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:43 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:02:45 INFO - Downloaded 58159403 bytes. 17:02:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:45 INFO - mkdir: /builds/slave/test/properties 17:02:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:45 INFO - Contents: 17:02:45 INFO - build_url:https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:46 INFO - Running post-action listener: _resource_record_post_action 17:02:46 INFO - Running post-action listener: set_extra_try_arguments 17:02:46 INFO - ##### 17:02:46 INFO - ##### Running populate-webroot step. 17:02:46 INFO - ##### 17:02:46 INFO - Running pre-action listener: _resource_record_pre_action 17:02:46 INFO - Running main action method: populate_webroot 17:02:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:46 INFO - '--tppagecycles', 17:02:46 INFO - '7'], 17:02:46 INFO - 'tests': ['tsvgm']}}, 17:02:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:46 INFO - 'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:46 INFO - 'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['damp', 'tps']}, 17:02:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:46 INFO - 'tests': ['damp', 'tps']}, 17:02:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['dromaeo_dom']}, 17:02:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['a11yr', 17:02:46 INFO - 'ts_paint', 17:02:46 INFO - 'tpaint', 17:02:46 INFO - 'sessionrestore', 17:02:46 INFO - 'sessionrestore_no_auto_restore', 17:02:46 INFO - 'tabpaint']}, 17:02:46 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:46 INFO - 'ts_paint', 17:02:46 INFO - 'tpaint', 17:02:46 INFO - 'sessionrestore', 17:02:46 INFO - 'sessionrestore_no_auto_restore', 17:02:46 INFO - 'tabpaint']}, 17:02:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:02:46 INFO - 'ts_paint', 17:02:46 INFO - 'tpaint', 17:02:46 INFO - 'sessionrestore', 17:02:46 INFO - 'sessionrestore_no_auto_restore', 17:02:46 INFO - 'tabpaint']}, 17:02:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:02:46 INFO - 'ts_paint', 17:02:46 INFO - 'tpaint', 17:02:46 INFO - 'sessionrestore', 17:02:46 INFO - 'sessionrestore_no_auto_restore', 17:02:46 INFO - 'tabpaint']}, 17:02:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['a11yr', 17:02:46 INFO - 'ts_paint', 17:02:46 INFO - 'tpaint', 17:02:46 INFO - 'sessionrestore', 17:02:46 INFO - 'sessionrestore_no_auto_restore', 17:02:46 INFO - 'tabpaint']}, 17:02:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['a11yr', 17:02:46 INFO - 'ts_paint', 17:02:46 INFO - 'tpaint', 17:02:46 INFO - 'sessionrestore', 17:02:46 INFO - 'sessionrestore_no_auto_restore', 17:02:46 INFO - 'tabpaint']}, 17:02:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['tsvgx', 17:02:46 INFO - 'tsvgr_opacity', 17:02:46 INFO - 'tart', 17:02:46 INFO - 'tscrollx', 17:02:46 INFO - 'cart']}, 17:02:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:46 INFO - 'tsvgr_opacity', 17:02:46 INFO - 'tart', 17:02:46 INFO - 'tscrollx', 17:02:46 INFO - 'cart']}, 17:02:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:46 INFO - 'talos_options': ['--disable-e10s'], 17:02:46 INFO - 'tests': ['tp5o']}, 17:02:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:46 INFO - 'tests': ['tp5o']}, 17:02:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:46 INFO - 'talos_options': ['--disable-e10s', 17:02:46 INFO - '--xperf_path', 17:02:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:46 INFO - 'tests': ['tp5n']}, 17:02:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:46 INFO - 'talos_options': ['--xperf_path', 17:02:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:46 INFO - 'tests': ['tp5n']}}, 17:02:46 INFO - 'talos.zip': {'path': '', 17:02:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:46 INFO - Running post-action listener: _resource_record_post_action 17:02:46 INFO - ##### 17:02:46 INFO - ##### Running create-virtualenv step. 17:02:46 INFO - ##### 17:02:46 INFO - Running pre-action listener: _resource_record_pre_action 17:02:46 INFO - Running main action method: create_virtualenv 17:02:46 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:02:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:46 INFO - Using real prefix '/usr' 17:02:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:47 INFO - Installing distribute.............................................................................................................................................................................................done. 17:02:49 INFO - Installing pip.................done. 17:02:49 INFO - Return code: 0 17:02:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:49 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 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:02:49 INFO - Using env: {'DISPLAY': ':0', 17:02:49 INFO - 'HOME': '/home/cltbld', 17:02:49 INFO - 'LANG': 'en_US.UTF-8', 17:02:49 INFO - 'LANGUAGE': 'en_US:en', 17:02:49 INFO - 'LOGNAME': 'cltbld', 17:02:49 INFO - 'MAIL': '/var/mail/cltbld', 17:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:49 INFO - 'MOZ_NO_REMOTE': '1', 17:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:49 INFO - 'NO_EM_RESTART': '1', 17:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:49 INFO - 'PWD': '/builds/slave/test', 17:02:49 INFO - 'SHELL': '/bin/bash', 17:02:49 INFO - 'SHLVL': '1', 17:02:49 INFO - 'TERM': 'linux', 17:02:49 INFO - 'TMOUT': '86400', 17:02:49 INFO - 'USER': 'cltbld', 17:02:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:49 INFO - '_': '/tools/buildbot/bin/python'} 17:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:02:49 INFO - Cleaning up... 17:02:49 INFO - Return code: 0 17:02:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:49 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 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:02:49 INFO - Using env: {'DISPLAY': ':0', 17:02:49 INFO - 'HOME': '/home/cltbld', 17:02:49 INFO - 'LANG': 'en_US.UTF-8', 17:02:49 INFO - 'LANGUAGE': 'en_US:en', 17:02:49 INFO - 'LOGNAME': 'cltbld', 17:02:49 INFO - 'MAIL': '/var/mail/cltbld', 17:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:49 INFO - 'MOZ_NO_REMOTE': '1', 17:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:49 INFO - 'NO_EM_RESTART': '1', 17:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:49 INFO - 'PWD': '/builds/slave/test', 17:02:49 INFO - 'SHELL': '/bin/bash', 17:02:49 INFO - 'SHLVL': '1', 17:02:49 INFO - 'TERM': 'linux', 17:02:49 INFO - 'TMOUT': '86400', 17:02:49 INFO - 'USER': 'cltbld', 17:02:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:49 INFO - '_': '/tools/buildbot/bin/python'} 17:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:49 INFO - Downloading/unpacking psutil>=0.7.1 17:02: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 17:02: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 17:02: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 17:02: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 17:02: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 17:02: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 17:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:51 INFO - Installing collected packages: psutil 17:02:51 INFO - Running setup.py install for psutil 17:02:51 INFO - building 'psutil._psutil_linux' extension 17:02:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:02:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:02:51 INFO - building 'psutil._psutil_posix' extension 17:02:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:02:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:02:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:52 INFO - Successfully installed psutil 17:02:52 INFO - Cleaning up... 17:02:56 INFO - Return code: 0 17:02:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:02:56 INFO - Using env: {'DISPLAY': ':0', 17:02:56 INFO - 'HOME': '/home/cltbld', 17:02:56 INFO - 'LANG': 'en_US.UTF-8', 17:02:56 INFO - 'LANGUAGE': 'en_US:en', 17:02:56 INFO - 'LOGNAME': 'cltbld', 17:02:56 INFO - 'MAIL': '/var/mail/cltbld', 17:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:56 INFO - 'MOZ_NO_REMOTE': '1', 17:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:56 INFO - 'NO_EM_RESTART': '1', 17:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:56 INFO - 'PWD': '/builds/slave/test', 17:02:56 INFO - 'SHELL': '/bin/bash', 17:02:56 INFO - 'SHLVL': '1', 17:02:56 INFO - 'TERM': 'linux', 17:02:56 INFO - 'TMOUT': '86400', 17:02:56 INFO - 'USER': 'cltbld', 17:02:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:56 INFO - '_': '/tools/buildbot/bin/python'} 17:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:02:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:02:58 INFO - Installing collected packages: mozsystemmonitor 17:02:58 INFO - Running setup.py install for mozsystemmonitor 17:02:58 INFO - Successfully installed mozsystemmonitor 17:02:58 INFO - Cleaning up... 17:02:58 INFO - Return code: 0 17:02:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:02:58 INFO - Using env: {'DISPLAY': ':0', 17:02:58 INFO - 'HOME': '/home/cltbld', 17:02:58 INFO - 'LANG': 'en_US.UTF-8', 17:02:58 INFO - 'LANGUAGE': 'en_US:en', 17:02:58 INFO - 'LOGNAME': 'cltbld', 17:02:58 INFO - 'MAIL': '/var/mail/cltbld', 17:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:58 INFO - 'MOZ_NO_REMOTE': '1', 17:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:58 INFO - 'NO_EM_RESTART': '1', 17:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:58 INFO - 'PWD': '/builds/slave/test', 17:02:58 INFO - 'SHELL': '/bin/bash', 17:02:58 INFO - 'SHLVL': '1', 17:02:58 INFO - 'TERM': 'linux', 17:02:58 INFO - 'TMOUT': '86400', 17:02:58 INFO - 'USER': 'cltbld', 17:02:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:58 INFO - '_': '/tools/buildbot/bin/python'} 17:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:03:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:03:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:01 INFO - Downloading docopt-0.6.1.tar.gz 17:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:03:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:03:01 INFO - Running setup.py install for blobuploader 17:03:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:03:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:03:01 INFO - Running setup.py install for requests 17:03:01 INFO - Running setup.py install for docopt 17:03:01 INFO - Successfully installed blobuploader requests docopt 17:03:01 INFO - Cleaning up... 17:03:01 INFO - Return code: 0 17:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:03:01 INFO - Using env: {'DISPLAY': ':0', 17:03:01 INFO - 'HOME': '/home/cltbld', 17:03:01 INFO - 'LANG': 'en_US.UTF-8', 17:03:01 INFO - 'LANGUAGE': 'en_US:en', 17:03:01 INFO - 'LOGNAME': 'cltbld', 17:03:01 INFO - 'MAIL': '/var/mail/cltbld', 17:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:01 INFO - 'MOZ_NO_REMOTE': '1', 17:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:01 INFO - 'NO_EM_RESTART': '1', 17:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:01 INFO - 'PWD': '/builds/slave/test', 17:03:01 INFO - 'SHELL': '/bin/bash', 17:03:01 INFO - 'SHLVL': '1', 17:03:01 INFO - 'TERM': 'linux', 17:03:01 INFO - 'TMOUT': '86400', 17:03:01 INFO - 'USER': 'cltbld', 17:03:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:01 INFO - '_': '/tools/buildbot/bin/python'} 17:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:02 INFO - Running setup.py (path:/tmp/pip-NAax_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:02 INFO - Running setup.py (path:/tmp/pip-RhIl4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:02 INFO - Running setup.py (path:/tmp/pip-Yn8Mas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:02 INFO - Running setup.py (path:/tmp/pip-GDRP1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:02 INFO - Running setup.py (path:/tmp/pip-tdAMzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:02 INFO - Running setup.py (path:/tmp/pip-uCj0en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:02 INFO - Running setup.py (path:/tmp/pip-9pZ1SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:02 INFO - Running setup.py (path:/tmp/pip-v6Ryjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:02 INFO - Running setup.py (path:/tmp/pip-EJlbf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:02 INFO - Running setup.py (path:/tmp/pip-sdOWGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:02 INFO - Running setup.py (path:/tmp/pip-0ZSvKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:02 INFO - Running setup.py (path:/tmp/pip-QAxULd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:03 INFO - Running setup.py (path:/tmp/pip-PNHxq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:03 INFO - Running setup.py (path:/tmp/pip-vuAE83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:03 INFO - Running setup.py (path:/tmp/pip-8DaPFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:03 INFO - Running setup.py (path:/tmp/pip-j8oA7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:03 INFO - Running setup.py (path:/tmp/pip-BsRlCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:03:03 INFO - Running setup.py install for manifestparser 17:03:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:03:03 INFO - Running setup.py install for mozcrash 17:03:03 INFO - Running setup.py install for mozdebug 17:03:03 INFO - Running setup.py install for mozdevice 17:03:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:03:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:03:03 INFO - Running setup.py install for mozfile 17:03:03 INFO - Running setup.py install for mozhttpd 17:03:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:03:03 INFO - Running setup.py install for mozinfo 17:03:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Running setup.py install for mozInstall 17:03:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Running setup.py install for mozleak 17:03:04 INFO - Running setup.py install for mozlog 17:03:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Running setup.py install for moznetwork 17:03:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Running setup.py install for mozprocess 17:03:04 INFO - Running setup.py install for mozprofile 17:03:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Running setup.py install for mozrunner 17:03:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Running setup.py install for mozscreenshot 17:03:04 INFO - Running setup.py install for moztest 17:03:05 INFO - Running setup.py install for mozversion 17:03:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:03:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:03:05 INFO - Cleaning up... 17:03:05 INFO - Return code: 0 17:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03: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')]} 17:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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')]} 17:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:03:05 INFO - Using env: {'DISPLAY': ':0', 17:03:05 INFO - 'HOME': '/home/cltbld', 17:03:05 INFO - 'LANG': 'en_US.UTF-8', 17:03:05 INFO - 'LANGUAGE': 'en_US:en', 17:03:05 INFO - 'LOGNAME': 'cltbld', 17:03:05 INFO - 'MAIL': '/var/mail/cltbld', 17:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:05 INFO - 'MOZ_NO_REMOTE': '1', 17:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:05 INFO - 'NO_EM_RESTART': '1', 17:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:05 INFO - 'PWD': '/builds/slave/test', 17:03:05 INFO - 'SHELL': '/bin/bash', 17:03:05 INFO - 'SHLVL': '1', 17:03:05 INFO - 'TERM': 'linux', 17:03:05 INFO - 'TMOUT': '86400', 17:03:05 INFO - 'USER': 'cltbld', 17:03:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:05 INFO - '_': '/tools/buildbot/bin/python'} 17:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:05 INFO - Running setup.py (path:/tmp/pip-yPugqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:05 INFO - Running setup.py (path:/tmp/pip-ETYmB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:05 INFO - Running setup.py (path:/tmp/pip-hx6848-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:05 INFO - Running setup.py (path:/tmp/pip-ZcdqXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:05 INFO - Running setup.py (path:/tmp/pip-dc3c3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:05 INFO - Running setup.py (path:/tmp/pip-x14JWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:05 INFO - Running setup.py (path:/tmp/pip-KWDUFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:05 INFO - Running setup.py (path:/tmp/pip-dOELB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:05 INFO - Running setup.py (path:/tmp/pip-E_uAWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:05 INFO - Running setup.py (path:/tmp/pip-4FBMVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:06 INFO - Running setup.py (path:/tmp/pip-jOXnuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:06 INFO - Running setup.py (path:/tmp/pip-4fTELn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:06 INFO - Running setup.py (path:/tmp/pip-e1CF0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:06 INFO - Running setup.py (path:/tmp/pip-7GtQDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:06 INFO - Running setup.py (path:/tmp/pip-AIX3w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:06 INFO - Running setup.py (path:/tmp/pip-ANmk4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:06 INFO - Running setup.py (path:/tmp/pip-nvXfmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:03:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:08 INFO - Downloading blessings-1.6.tar.gz 17:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:03:08 INFO - Installing collected packages: blessings 17:03:08 INFO - Running setup.py install for blessings 17:03:08 INFO - Successfully installed blessings 17:03:08 INFO - Cleaning up... 17:03:08 INFO - Return code: 0 17:03:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:08 INFO - Reading from file tmpfile_stdout 17:03:08 INFO - Current package versions: 17:03:08 INFO - argparse == 1.2.1 17:03:08 INFO - blessings == 1.6 17:03:08 INFO - blobuploader == 1.2.4 17:03:08 INFO - docopt == 0.6.1 17:03:08 INFO - manifestparser == 1.1 17:03:08 INFO - mozInstall == 1.12 17:03:08 INFO - mozcrash == 0.17 17:03:08 INFO - mozdebug == 0.1 17:03:08 INFO - mozdevice == 0.48 17:03:08 INFO - mozfile == 1.2 17:03:08 INFO - mozhttpd == 0.7 17:03:08 INFO - mozinfo == 0.9 17:03:08 INFO - mozleak == 0.1 17:03:08 INFO - mozlog == 3.1 17:03:08 INFO - moznetwork == 0.27 17:03:08 INFO - mozprocess == 0.22 17:03:08 INFO - mozprofile == 0.28 17:03:08 INFO - mozrunner == 6.11 17:03:08 INFO - mozscreenshot == 0.1 17:03:08 INFO - mozsystemmonitor == 0.0 17:03:08 INFO - moztest == 0.7 17:03:08 INFO - mozversion == 1.4 17:03:08 INFO - psutil == 3.1.1 17:03:08 INFO - requests == 1.2.3 17:03:08 INFO - wsgiref == 0.1.2 17:03:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:03:08 INFO - Using env: {'DISPLAY': ':0', 17:03:08 INFO - 'HOME': '/home/cltbld', 17:03:08 INFO - 'LANG': 'en_US.UTF-8', 17:03:08 INFO - 'LANGUAGE': 'en_US:en', 17:03:08 INFO - 'LOGNAME': 'cltbld', 17:03:08 INFO - 'MAIL': '/var/mail/cltbld', 17:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:08 INFO - 'MOZ_NO_REMOTE': '1', 17:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:08 INFO - 'NO_EM_RESTART': '1', 17:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:08 INFO - 'PWD': '/builds/slave/test', 17:03:08 INFO - 'SHELL': '/bin/bash', 17:03:08 INFO - 'SHLVL': '1', 17:03:08 INFO - 'TERM': 'linux', 17:03:08 INFO - 'TMOUT': '86400', 17:03:08 INFO - 'USER': 'cltbld', 17:03:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:08 INFO - '_': '/tools/buildbot/bin/python'} 17:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:03:09 INFO - Cleaning up... 17:03:09 INFO - Return code: 0 17:03:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:03:09 INFO - Using env: {'DISPLAY': ':0', 17:03:09 INFO - 'HOME': '/home/cltbld', 17:03:09 INFO - 'LANG': 'en_US.UTF-8', 17:03:09 INFO - 'LANGUAGE': 'en_US:en', 17:03:09 INFO - 'LOGNAME': 'cltbld', 17:03:09 INFO - 'MAIL': '/var/mail/cltbld', 17:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:09 INFO - 'MOZ_NO_REMOTE': '1', 17:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:09 INFO - 'NO_EM_RESTART': '1', 17:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:09 INFO - 'PWD': '/builds/slave/test', 17:03:09 INFO - 'SHELL': '/bin/bash', 17:03:09 INFO - 'SHLVL': '1', 17:03:09 INFO - 'TERM': 'linux', 17:03:09 INFO - 'TMOUT': '86400', 17:03:09 INFO - 'USER': 'cltbld', 17:03:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:09 INFO - '_': '/tools/buildbot/bin/python'} 17:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:09 INFO - Downloading/unpacking jsonschema 17:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:03:11 INFO - Downloading/unpacking functools32 (from jsonschema) 17:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:11 INFO - Downloading functools32-3.2.3-2.tar.gz 17:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:03:11 INFO - warning: no files found matching '*.txt' 17:03:11 INFO - no previously-included directories found matching 'build' 17:03:11 INFO - no previously-included directories found matching 'dist' 17:03:11 INFO - no previously-included directories found matching '.git*' 17:03:11 INFO - Installing collected packages: jsonschema, functools32 17:03:11 INFO - Running setup.py install for functools32 17:03:11 INFO - warning: no files found matching '*.txt' 17:03:11 INFO - no previously-included directories found matching 'build' 17:03:11 INFO - no previously-included directories found matching 'dist' 17:03:11 INFO - no previously-included directories found matching '.git*' 17:03:11 INFO - Successfully installed jsonschema functools32 17:03:11 INFO - Cleaning up... 17:03:11 INFO - Return code: 0 17:03:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe5f5eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:03:11 INFO - Using env: {'DISPLAY': ':0', 17:03:11 INFO - 'HOME': '/home/cltbld', 17:03:11 INFO - 'LANG': 'en_US.UTF-8', 17:03:11 INFO - 'LANGUAGE': 'en_US:en', 17:03:11 INFO - 'LOGNAME': 'cltbld', 17:03:11 INFO - 'MAIL': '/var/mail/cltbld', 17:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:11 INFO - 'MOZ_NO_REMOTE': '1', 17:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:11 INFO - 'NO_EM_RESTART': '1', 17:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:11 INFO - 'PWD': '/builds/slave/test', 17:03:11 INFO - 'SHELL': '/bin/bash', 17:03:11 INFO - 'SHLVL': '1', 17:03:11 INFO - 'TERM': 'linux', 17:03:11 INFO - 'TMOUT': '86400', 17:03:11 INFO - 'USER': 'cltbld', 17:03:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:11 INFO - '_': '/tools/buildbot/bin/python'} 17:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:11 INFO - Downloading/unpacking flake8 17:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:03:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:03:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:03:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:03:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:03:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:03:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:03:14 INFO - no previously-included directories found matching 'docs/_build' 17:03:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:03:14 INFO - Running setup.py install for pep8 17:03:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:03:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:03:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:03:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:03:14 INFO - no previously-included directories found matching 'docs/_build' 17:03:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:03:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:03:14 INFO - Cleaning up... 17:03:14 INFO - Return code: 0 17:03:14 INFO - Running post-action listener: _resource_record_post_action 17:03:14 INFO - Running post-action listener: _start_resource_monitoring 17:03:14 INFO - Starting resource monitoring. 17:03:14 INFO - ##### 17:03:14 INFO - ##### Running install step. 17:03:14 INFO - ##### 17:03:14 INFO - Running pre-action listener: _resource_record_pre_action 17:03:14 INFO - Running main action method: install 17:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:14 INFO - Reading from file tmpfile_stdout 17:03:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:03:15 INFO - Reading from file tmpfile_stdout 17:03:15 INFO - Output received: 17:03:15 INFO - Usage: mozinstall [options] installer 17:03:15 INFO - Options: 17:03:15 INFO - -h, --help show this help message and exit 17:03:15 INFO - -d DEST, --destination=DEST 17:03:15 INFO - Directory to install application into. [default: 17:03:15 INFO - "/builds/slave/test"] 17:03:15 INFO - --app=APP Application being installed. [default: firefox] 17:03:15 INFO - mkdir: /builds/slave/test/build/application 17:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:03:31 INFO - Reading from file tmpfile_stdout 17:03:31 INFO - Output received: 17:03:31 INFO - /builds/slave/test/build/application/firefox/firefox 17:03:31 INFO - Running post-action listener: _resource_record_post_action 17:03:31 INFO - ##### 17:03:31 INFO - ##### Running run-tests step. 17:03:31 INFO - ##### 17:03:31 INFO - Running pre-action listener: _resource_record_pre_action 17:03:31 INFO - Running main action method: run_tests 17:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:03:31 INFO - Python 2.7.3 17:03:31 INFO - Return code: 0 17:03:31 INFO - grabbing minidump binary from tooltool 17:03: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')]} 17:03:31 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 0x197b410>, '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 0x197c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:03:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:03:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:03:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:03:31 INFO - Return code: 0 17:03:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:03:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:03:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:03:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:03:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:03:32 INFO - Return code: 0 17:03:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 17:03:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 17:03:32 INFO - Using env: {'DISPLAY': ':0', 17:03:32 INFO - 'HOME': '/home/cltbld', 17:03:32 INFO - 'LANG': 'en_US.UTF-8', 17:03:32 INFO - 'LANGUAGE': 'en_US:en', 17:03:32 INFO - 'LOGNAME': 'cltbld', 17:03:32 INFO - 'MAIL': '/var/mail/cltbld', 17:03:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:03:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:32 INFO - 'MOZ_NO_REMOTE': '1', 17:03:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:32 INFO - 'NO_EM_RESTART': '1', 17:03:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:32 INFO - 'PWD': '/builds/slave/test', 17:03:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:03:32 INFO - 'SHELL': '/bin/bash', 17:03:32 INFO - 'SHLVL': '1', 17:03:32 INFO - 'TERM': 'linux', 17:03:32 INFO - 'TMOUT': '86400', 17:03:32 INFO - 'USER': 'cltbld', 17:03:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322', 17:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:32 INFO - '_': '/tools/buildbot/bin/python'} 17:03:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 17:03:32 INFO - mozversion application_buildid: 20160414143005 17:03:32 INFO - mozversion application_changeset: 3e85a84c7d68632e1098cc9374787dc8f54ce24f 17:03:32 INFO - mozversion application_display_name: Nightly 17:03:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:03:32 INFO - mozversion application_name: Firefox 17:03:32 INFO - mozversion application_remotingname: firefox 17:03:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:03:32 INFO - mozversion application_vendor: Mozilla 17:03:32 INFO - mozversion application_version: 48.0a1 17:03:32 INFO - mozversion platform_buildid: 20160414143005 17:03:32 INFO - mozversion platform_changeset: 3e85a84c7d68632e1098cc9374787dc8f54ce24f 17:03:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:03:32 INFO - mozversion platform_version: 48.0a1 17:03:32 INFO - using testdate: 1460678612 17:03:32 INFO - actual date: 1460678612 17:03:32 INFO - starting webserver on 'localhost:35130' 17:03:32 INFO - SUITE-START | Running 2 tests 17:03:32 INFO - TEST-START | dromaeo_css 17:03:32 INFO - operating with platform_type : linux_ 17:03:32 INFO - Initialising browser for dromaeo_css test... 17:03:32 INFO - TEST-INFO | started process 6588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzAe2c/profile http://localhost:35130/getInfo.html) 17:03:36 INFO - PROCESS | 6588 | 17:03:36 INFO - PROCESS | 6588 | (process:6658): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:03:37 INFO - PROCESS | 6588 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:03:38 INFO - PROCESS | 6588 | __metrics Screen width/height:1600/1200 17:03:38 INFO - PROCESS | 6588 | colorDepth:24 17:03:38 INFO - PROCESS | 6588 | Browser inner width/height: 1024/697 17:03:38 INFO - PROCESS | 6588 | __metrics 17:03:38 ERROR - PROCESS | 6588 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:03:39 INFO - TEST-INFO | 6588: exit 0 17:03:39 INFO - Browser initialized. 17:03:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:03:39 INFO - TEST-INFO | started process 6709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzAe2c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:41 INFO - PROCESS | 6709 | 17:03:41 INFO - PROCESS | 6709 | (process:6771): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:03:51 INFO - PROCESS | 6709 | RSS: Main: 162836480 17:03:51 INFO - PROCESS | 6709 | 17:04:41 INFO - PROCESS | 6709 | 1460678681131 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:06:48 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:35130/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35130/tests/dromaeo/cssquery-ext.html) 17:06:49 INFO - PROCESS | 6709 | RSS: Main: 167907328 17:06:49 INFO - PROCESS | 6709 | 17:09:51 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:35130/tests/dromaeo/cssquery-ext.html (next: http://localhost:35130/tests/dromaeo/cssquery-jquery.html) 17:09:52 INFO - PROCESS | 6709 | RSS: Main: 165310464 17:09:52 INFO - PROCESS | 6709 | 17:12:54 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:35130/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35130/tests/dromaeo/cssquery-mootools.html) 17:12:54 INFO - PROCESS | 6709 | RSS: Main: 166023168 17:12:54 INFO - PROCESS | 6709 | 17:15:56 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:35130/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35130/tests/dromaeo/cssquery-prototype.html) 17:15:57 INFO - PROCESS | 6709 | RSS: Main: 163700736 17:15:57 INFO - PROCESS | 6709 | 17:18:59 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:35130/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35130/tests/dromaeo/cssquery-yui.html) 17:19:00 INFO - PROCESS | 6709 | RSS: Main: 165044224 17:19:00 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | Cycle 1(1): loaded http://localhost:35130/tests/dromaeo/cssquery-yui.html (next: http://localhost:35130/tests/dromaeo/cssquery-dojo.html) 17:22:02 INFO - PROCESS | 6709 | RSS: Main: 167522304 17:22:02 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | __start_tp_report 17:22:02 INFO - PROCESS | 6709 | _x_x_mozilla_page_load 17:22:02 INFO - PROCESS | 6709 | _x_x_mozilla_page_load_details 17:22:02 INFO - PROCESS | 6709 | |i|pagename|runs| 17:22:02 INFO - PROCESS | 6709 | |0;dojo.html;3166.5250212468127;3181.793183443076;3212.742980561555;3222.1783445221463;3226.2902161524457;5335.5198032177095;5363.088274993251;5390.083685773418;5394.136938089897;5440.836774896749;5343.599230057752;5364.222187782769;5386;5389.434109418514;5515.531179849708;4814.422269327685;4840.709557426548;4907.067657145149;4913.115639184964;4942.085714142877;4784.258439941815;4793.4487533933525;4833.516648335173;4871.829485967992;4876.804927802884;4872.78072486739;4874.707517548941;4880.121578115938;4909.631777616693;4909.656324057318;4924.8768780780765;4925.802967881316;4932.506749325074;4948.87627809304;4953.975230123862;4779.80880764769;4822.831200907952;4896.075748344472;4902.803887844482;4941.728204948727;5246.973765131188;5251.291075704769;5283.841484755425;5290.761915713802;5303.522682958553;5675.2054712340305;5681.289838770153;5702.144678298247;5726.713664316809;5734.8279551613105;5597.944020559783;5717.9714101429645;5779.942200578024;5810.622309549908;5872.354041055481;5289.391719952217;5325.946740532584;5339.332583427072;5347.572194224453;5354.14333706609;5739.7704091836695;5751.741171647286;5769.336526299446;5808.380250112085;5821.039528477754;5553.50018498329;5629.0149223885655;5666.150077488327;5677.574181936371;5714.599978001583;5667.744951477193;5668.688222147739;5675.1770993205755;5676.858078548069;5683.54531637468;5521.254630624814;5601.887962240732;5630.296212973379;5643.125315576092;5653.293338332708;5586.301712285965;5695.515881150149;5744.253247077853;5760.855978600484;5816.331121921034;4302.698811083194;4365.956340436555;4368;4369.737815731066;4409.33859921008;3822.5986271441097;3825.923481530354;3827.6937844972335;3861.7489863158803;3864.942025869614;5337.919931201035;5369.4362091980565;5382.515573598395;5391.757370918318;5411.485908838654;5695.060315048054;5711.400302968212;5716.485516303553;5719.628224165416;5723.713814309268;5353.946460535422;5358.303420555303;5414.648047876875;5444.700541470257;5465.480779325958;4857.708537487762;4858.732769697701;4883.4628190898975;4891.364122664031;4923.5814955729165;5773.8556536086935;5873.500752436005;5880.588358814842;5914.651098137316;5940.168376427304;5696.829095127153;5701.059325211294;5723.370429252779;5761.366249712612;5764.3371012332445;5832.358440571618;5862.443067908542;5870.7945221918735;5871.1486834407915;5876.735546900485;5591.245181900392;5600.439956004367;5605.467480589337;5611.7194140292;5614.606977511535;5581.162825576196;5643.83068507929;5686.60193786431;5689.573282003784;5735.283089613798;5621.80323688669;5667.064934285797;5671.376148623565;5678.914816277676;5687.715614219355;5584.888302234014;5631.802886898939;5635.154726791015;5644.915326270027;5647.124695672177;5341.172118321666;5527.50252477279;5586.16207568868;5588.832335029955;5628.240187574625;5471.671699698031;5544.916826247691;5611.859703507445;5647.6893770843;5656.773729050792;5467.507924286833;5488.25908502363;5507.173923911445;5511.834644960658;5518.862028449321 17:22:02 INFO - PROCESS | 6709 | |1;ext.html;610.3255902228038;632.4813652804701;652.4812773844792;674.8312921769558;675.5102550650779;36496.81751591245;38305.233895322075;38308.42537361935;38320.80839595802;38324.80837595811;39639;40248;40509.392359114565;40528.18943621126;40574.797126014404;8483.745487635366;8694.782630434258;8703.651853925867;8757.168069033432;8767.780805479882;8623.611937462798;8633.870491942625;8697.95651021744;8756.60595273211;8768;8837.558122093902;8875.06811784763;8939.95530022349;8942;8970.237529809974;8870.689525866595;8903.599338029804;8924.8661270081;8938.284937205008;8966.820663586757;8688.131186881325;8835.823283534357;8873.068327825615;8895.822083558358;8901;40237.39643905344;40351.39472907909;40587;40688.79655601703;40754.59245407538;3317.137544238491;3355.8154301513405;3359.932801343984;3788.1287303920253;3949.7984391445107;31102.066937991898;31151.37697246065;31352;31361;32227.033189004367;4426.889327766799;4440.977795111036;4476.686631935766;4550.613197878184;4585.174668559658;293434.53282733663;294611;295997;297095;298143;50754.98490030179;58174.41825581775;60916.39083609196;60932.39067609267;60997;55688.443115569135;55955.440445595836;56064.71967640217;56142.6664466875;56269.71865140648;15534.145621990672;15766.605834854221;15787;15799.21003949821;15803.762943555856;11910.702232444084;12103.213291136224;12128.393580321124;12185.756284874253;12236.449359778831;16251.918740406223;16334.101624410772;16416;16417.507474775775;16451.83548164527;6245.437910588069;6410.1987251593555;6518.804435866931;6582.868342633121;6619.867602648016;1070.5343175718588;1120.843081968525;1142.708609304622;1152.3949926288765;1157.9305241685527;30908.53637195444;31035.534466983012;31646.525302120488;32118;32285.192870178435;1187.9406029698653;1189.7323102301914;1208.3112625803208;1270.9682257943625;1334.159479527891;16507.9302121499;16576.419825306057;16630.50108496747;16753;16966;411345;414887;416565.9171704122;417892;418225;55749;55882;56228.71885640546;56464.15303770447;56565;1241.2924632959307;1257.2645002673355;1257.6792917805901;1260.4454040222272;1370.390176371525;30303;31226;31596.526052109697;32028;32151.678483215805;52848.207276890105;55245.44754552403;55269.44730552643;55353.723231383585;55438.445615544944;270919;273947;277809;278949;280651;26810.59784103201;27052.188434347;27210.591841122794;27325.590116148673;27419.451610968066;46234.30648540207;46753;47308.2903756437;47572.52427475681;48110.27834582414;40468.59531404766;40834.38748418835;40873.182536349705;41281.58718412898;41636;39384.40923386209;39426.80286598549;40740.59259407368;40816.591834082465;41097.178056438104;40742.1851562973;42124.15751685011;42479.150416990866;42755.144897101265;43024.354634681134;30512.694873051874;31924.36151277008;32746.672533274363;32772.83613581917;32784.67215327816;26225;26748.19755407341;27182.32044198832;27380.452390951672;28061.438771224053 17:22:02 INFO - PROCESS | 6709 | |2;jquery.html;382.09634215081326;387.8293550837631;392.844826293614;393.052742889636;402.95768944260834;17398;19050.809491905078;19171.712424313646;19251.99999999998;19288.614227715454;16391.262393192304;16457.34170633176;16488.917555412205;16548.089855058;17702.64594708105;5629.7185140743;5746.827595172131;5784.855378615526;5790;5823.970880145594;5291.2327712481665;5545.500904918556;5554.166874968747;5596.496315331619;5600.915986260209;5570.108782594785;5588.245586845765;5631.408702086263;5636.408177141403;5658.490735833774;5467.726613669321;5573.554115670737;5599.972000139994;5602.943970560304;5630.071038278679;5342.439043900412;5397.433269506684;5405.18922161675;5405.432429594875;5809.88380232393;12286;12327.630171094792;12379.62861114168;12423.937880310541;12526;2272.715910511186;2352.752960939094;2356.363781778927;2365.077619728307;2392.2583998960376;9485.478298693639;9654.806903861954;9746.853797193047;10637;12561.309127997956;1853.629274145163;1940.3596813051659;1947.3573720672287;1963.8821670699804;2007.7088822120857;50459.74770126126;51256.48743512554;60752.39247607512;61025.694871525804;65188;10472.790544189074;10477.747284333906;10588.629397971034;10646.787064258826;10787.946060269649;14618.195999220145;14618.63453413652;14660.633484162769;14769.63075923089;14822.851771482363;7694.769156925301;7883.2116788321855;7998.320142787812;8073.515589064675;8086.83826323482;7578.280063393969;7638.770836874903;7762.534247945141;7780.14418413974;7788.585538483088;4556.270996640522;4621.56731413263;4643.164230438553;4649.18639238132;4700.341952126705;1793.9635819406335;1886.3963531670008;1935.632229876319;1949.2787668562723;2005.4585261979184;937.4328531238502;1040.7918416316768;1076.359566058194;1129.7627498225465;1133.0652211925194;17623.206955687026;18085.457436276934;18312.81687183138;18468.630627387378;18641.161147748382;996.2826764729383;1018.6994836523244;1041.7239431550645;1054.836500342448;1077.4020418667558;10169.288149829588;10270.178385729123;10352.792944141225;10370.325928814604;10450.268481206243;526688;533758;537077;540785;547112;89611.55194224117;90758;91283.54358228167;92343.5382823095;92686.53656731673;1030.8041472120274;1039.594558122333;1052.1425038593675;1056.3503445381189;1067.0716476665195;15991;16241.51275461738;16458.83541164621;16549.751753723944;16570.254338555034;36681.266374672894;36854.26291474102;37068.44397333988;37343.6265637351;37692.81153594214;46782;48984.510154897995;51327.48672513227;52779.472205278995;53977.73011134919;8050.033995920527;8095.069067057364;8272.710455134042;8358.62386192635;8370.832583348178;8894.4663320201;11739.295642261492;12345.197562158432;12369.567065152676;12379.690507737017;10349.223808214263;10838.078763305208;10880.619178328721;11415.828762568734;11586.652400428;5967.6121052131475;10247.487625618838;10948.945255273673;11150.330980141218;11373.431328433711;11775.470103845519;11862.22895511789;12240.816387754012;12271.202371845802;12360.38198090074;7839.412044096602;8124.187581241828;8216.630251638571;8302.626381812712;8318.251357377865;11127.944360278147;11532.25040372373;11552.711182220512;11786.116041296766;11848.585299514476 17:22:02 INFO - PROCESS | 6709 | |3;mootools.html;1408.7393832141054;1482.251463011179;1599.6560739441024;1794.1298470241923;1817.3094224194804;7060.576365418078;7522.5110367826055;7689.615519224044;7785.805354866138;7820.804479887998;7658.770236892902;7731.845363092749;7738.729144479944;7773.494722843011;7802.8439431211345;2226.755056943735;2232.363776323748;2248.15694114707;2254.695616091823;2256.4584499720113;2215.3907675389237;2225.321277010511;2233.095596283508;2243.0354947372703;2244.842860999731;2196.406970118067;2219.3896678413403;2225.3880182949656;2239.2162743039967;2254.86470811751;2216.2907869481774;2219.0901730290584;2222.622154233792;2234.0393630738777;2234.0393630738777;2149.6345621244427;2163.0590693048575;2164.166795783635;2166.9024893879814;2176.4994051368117;7876.05487341517;7925.3263472604895;7949.403794715419;7966.203379662045;8001.359891208747;4632.166210082184;4740.810367585293;4766.475687674388;4773.928391074137;4777.211760059586;3112.863804711287;3183.8567264473154;3244.0916543367894;3272.803631782077;3296.785708928912;1143.1026644084436;1149.4597539156582;1152.9538818447252;1155.1394211312627;1167.357953125786;10592.894071059267;10653.467326633638;10664.466776661136;10678.252522323362;10696.251262411633;4107.116969851437;4225.809838557211;4339.240632889232;4341.131773645284;4355.2813785725;9036.548172591476;9096.681616143404;9098.545072746336;9107;9113.681021164228;4781.330613714083;4784.760761961888;4787.928181077286;4798.904021919542;4814;3848.99926019237;4434.889127771767;4462.799174037176;4471.083427897273;4524.932126018112;3630.5824830144343;3645.5989841117457;3689.94465083024;3725.8882233533036;3769.3780526212868;1195.611426286443;1195.7847587434346;1221.6884694403047;1231.8891299782883;1237.0412929979339;763.7097902796902;829.9625468164794;846.4413487098609;878.6792820620427;883.8718385834018;5396.163594642837;5609.971950140305;5738.569607279471;5739.684317362585;5821.505172060338;980.8181141724206;992.5781542844262;1028.0387837372082;1049.317943336837;1066.9466526673634;3812.8284227209842;3822.2164456286396;3946.5264168299987;3951.4863067801575;4005.539362973237;9198.310126740522;9461.148496635336;9521.523923803783;9541.045895410403;9541.379810312308;9496.382735122195;9522.333436659506;9587.856182157273;9590.712278631652;9631.325807193569;7104.573725576585;7305.3425191732995;7434.405247580181;7447.44144189188;7474.476786624993;5547.089302042132;5548.334199895877;5585.273914391103;5654.434556544313;5717.171010203414;8690.130986901511;8769.956150219208;8821.470711757314;8916.55417229149;9007;8759.080296568769;8925.107489251022;8995.280377569648;9010.954945225232;9142.314326425412;6387.712552935036;6720.630365329954;6812.795616131524;6871.072405225431;6914.619695916773;7634.580098094658;7681.1934746850775;7699.307062364414;7720.382369410546;7751.689932402641;6827.761028363983;7171.390431813355;7190.245024272376;7209.35115839577;7274.781756547312;6928.930710692828;6940.514164008673;6954.79135625932;6987.1266091738535;7015.6842942066705;6240.812775616739;6242.65665388408;6256.5620406572925;6348.396902294275;6397.96801015992;5074.82238121664;5122.923156152735;5169.327987361619;5188.818391356284;5266.420693723764;5012.198048312398;5066.08810414129;5066.898662026812;5121.641485096007;5123.949590334048 17:22:02 INFO - PROCESS | 6709 | |4;prototype.html;298.94768415527284;304.06045319961316;306.1901271137839;306.2756580686676;308.84094691234003;5918.1122831575285;6016.909746353808;6021.217241758565;6026.337102918681;6047.697615119248;5759.337676167242;5767.452092051259;5934.744796977154;5954.70226488675;5961.761529538813;4173.123644034748;4311.3101903695415;4474.217012022883;4474.351219073249;4505.994832299628;4464.308032255006;4489.079738653584;4498.437695288089;4500.167469018242;4513.864584062483;4406.581374769392;4444.911101777962;4448.088141930896;4468.664850136237;4479.081788233404;4369.453818272716;4437.4009508716235;4443.644508439334;4471.6199123074575;4473.964346222461;3852.210296889131;3863.014931192556;3864.381698928158;3874.2057878134915;3878.8642397516232;5737.049403202889;5765.682887441189;5774.105013722879;5785.846713541088;5811.070228763378;5011.699298042129;5068.695878247317;5083.415407228142;5105.336306280197;5157.149070403379;6202.968985155046;6217.782377616762;6234.781782637586;6236.18929539157;6262.5929314594405;4238.639715624176;4249.0652056547815;4249.915001699948;4268.103698223377;4271.6582673386365;6057.273127224717;6391.776287829904;6409.327020662809;6409.903851442232;6443.259025212114;4211.178820130107;4342.478902531717;4354.368616550582;4359;4361.171377438277;4351.19502891966;4411.735295882193;4415.873952142183;4424;4442.2892337225885;5135.101357262539;5151.201563757623;5151.356080489939;5174.922376164361;5179.482051794866;6223.439890409885;6250.656213908188;6263.404976527223;6266.686665666698;6270;1492.5820770184366;1515.2272341105895;1538.2462593329187;1538.9307481163376;1538.9384424623113;958.7507248115401;1002.2082554781641;1011.9797604047877;1032.3547782635853;1032.6695457453543;5910.940890591125;5943.375945525744;5949.494292985059;5998.3701711320555;6031.638101713911;6398.712057957403;6413.973764197706;6434.163558737334;6436.485081193493;6463.547551671338;5839.240898683144;5951.315598706117;5992.880142397127;5998.520118390518;6026.427489388501;3374.6625337466057;3411.863525458954;3414.1904790461094;3420.6579342066093;3424.3493736190544;6499.805005849832;6549.476041916635;6573.605583664996;6624.8343791405605;6706.26231114577;6516.609003459807;6519.380658837403;6551.770688025897;6571.145751052428;6587;6517.967410162919;6629.5359324846795;6638.668066596748;6692.665366731644;6865.661196066819;6562.114114594468;6565.441937435371;6577.868442631025;6579.4736421087155;6594.340141221668;6153.476954458921;6446.129772480843;6451.451626611791;6495.772647957298;6499.38255865692;6769.390754831892;6780.32196780318;6788.66056697173;6798.286179951232;6830.521863469509;4195.622393984556;4248.426462427533;4259.275923093143;4265.680073994401;4267.743935363888;6348.604444621937;6549.279579246374;6554.344565543408;6584.8024559263295;6611.537192396486;6351.30135685065;6366.376573973607;6373.904391434039;6395.552311338161;6422;6030.678188897218;6261.592996455216;6363.454618152776;6371.74513019474;6395.520335974914;5994.730237139252;6067.12026756109;6249.34381889895;6254.28075771274;6263.78076767311;6339.746410143543;6409.87827130241;6417.197850268716;6417.39034791694;6447.387498187664;6061.605995610271;6200.782972595937;6231.875362492816;6257.405546473078;6276.6547839869245 17:22:02 INFO - PROCESS | 6709 | |5;yui.html;782.3662833105187;788.7909703928458;810.4853418079522;839.6263662670115;844.1347618690837;13921.58235252944;13929.860701392983;13943.233122178277;13949.302534873254;14145.363458644348;13227.801582976263;13331.53339633113;13344.199348039125;13348.399322030507;13349.132306400077;662.6024385368764;762.0969151555397;789.7512283630653;791.3708601661692;799.8320352725906;794.4756460735915;797.972070977516;799.596203917024;802.2018091998469;804.0994086622991;798.4530596541359;807.2976510435929;812.5733989655448;813.0446725098016;813.515958004986;799.5282783157936;811.2617518058568;814.5723495165086;814.6049166154411;817.0685418622775;592.7006861534941;596.2755252368349;596.7344531683402;599.9550033747487;601.1913975702673;13951.372188251553;14054.859451405457;14107.224102674349;14118.223497707622;14136.646583835383;13901;14093.2953352333;14192.787108193384;14254.786178207336;14321;11245.212835101545;11254.831177532344;11294.265872718248;11450.854914508482;11512.942435287854;3893.8247778849736;3950.5654378018394;3991.5808840071663;3998.960010399888;4131.834726610932;56340;57291.71354143203;58560.12159817649;58566.12150817741;58625.706871465794;9453.858192127123;9568.780565148758;10721.571137154426;10897.509612067475;10973.231873768918;19125.61748765017;19244.23023079061;19459;19520.21919123219;19547.804521954884;8231.95884020576;8297.792555186168;8335.791605209919;8415.284700800377;8637;4571.457046043412;4893.975530122327;4907.55831975124;4979.377577802775;5091.7963281469065;3206.8556914938886;3255.9348813023607;3268;3270.3132342207928;3307.2724000719804;580.7067430947429;639.2424976402978;648.160631981585;650.9511786616023;651.5146216069058;635.9682015899186;687.6767919078026;715.2025491576958;721.3760097515716;743.6319022084103;8945.46327220369;9076.500792456478;9148.542572871464;9155.954220228856;9472.763180920532;688.9655517224119;701.6281370873445;712.1809918593659;712.8788106021989;720.657687598397;4287.935680964788;4410.845620403271;4413.293872980308;4438.933415998763;4450.132224216247;60721.39278607246;61452;62228;62778.68610656918;63349.36650633527;54008.45991540113;55463.445365546635;55779.16331255034;55969;56268.15597766037;44700.3294950576;44957.999999999345;50618;51145.7442712784;51485.48514514807;8872.866906996529;9062.229710474683;9191.632334706537;9487.146156845916;9585.281103917374;31766;32269.51595726019;33051.66948330486;33502.66497334996;33921.32157356889;41462;44271.77864110659;45730.08539829118;46676;46921;11876.643700688994;11881.82177267359;11930.4034798258;12011.879881201075;12224.327661978676;12849.87150128524;13235.272060036405;13274.77011295023;13324.133931294435;13670.453181872614;12930.288834114213;12939.805902911276;13048.282344471145;13110.868891310965;13121.147125436815;11268.7746245073;11318.94340528292;11500.94249528747;11894.583689570823;12123.878321293914;11952.223105498115;12899;12988.480460781462;13122.08145429849;13452.865471345161;10703.839442408525;10805.891941080488;10950.397728124712;11064.28082174656;11284.9435752824;10793.244472886823;11303.660890173307;11530.423478826193;11601.477933493183;11799.528018879491 17:22:02 INFO - PROCESS | 6709 | __end_tp_report 17:22:02 INFO - PROCESS | 6709 | __start_cc_report 17:22:02 INFO - PROCESS | 6709 | _x_x_mozilla_cycle_collect,337 17:22:02 INFO - PROCESS | 6709 | __end_cc_report 17:22:02 INFO - PROCESS | 6709 | __startTimestamp1460679722480__endTimestamp 17:22:02 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | ------- Summary: start ------- 17:22:02 INFO - PROCESS | 6709 | Number of tests: 6 17:22:02 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | [#0] dojo.html Cycles:165 Average:5307.13 Median:5521.25 stddev:588.13 (10.7%) stddev-sans-first:565.45 17:22:02 INFO - PROCESS | 6709 | Values: 3166.5 3181.8 3212.7 3222.2 3226.3 5335.5 5363.1 5390.1 5394.1 5440.8 5343.6 5364.2 5386.0 5389.4 5515.5 4814.4 4840.7 4907.1 4913.1 4942.1 4784.3 4793.4 4833.5 4871.8 4876.8 4872.8 4874.7 4880.1 4909.6 4909.7 4924.9 4925.8 4932.5 4948.9 4954.0 4779.8 4822.8 4896.1 4902.8 4941.7 5247.0 5251.3 5283.8 5290.8 5303.5 5675.2 5681.3 5702.1 5726.7 5734.8 5597.9 5718.0 5779.9 5810.6 5872.4 5289.4 5325.9 5339.3 5347.6 5354.1 5739.8 5751.7 5769.3 5808.4 5821.0 5553.5 5629.0 5666.2 5677.6 5714.6 5667.7 5668.7 5675.2 5676.9 5683.5 5521.3 5601.9 5630.3 5643.1 5653.3 5586.3 5695.5 5744.3 5760.9 5816.3 4302.7 4366.0 4368.0 4369.7 4409.3 3822.6 3825.9 3827.7 3861.7 3864.9 5337.9 5369.4 5382.5 5391.8 5411.5 5695.1 5711.4 5716.5 5719.6 5723.7 5353.9 5358.3 5414.6 5444.7 5465.5 4857.7 4858.7 4883.5 4891.4 4923.6 5773.9 5873.5 5880.6 5914.7 5940.2 5696.8 5701.1 5723.4 5761.4 5764.3 5832.4 5862.4 5870.8 5871.1 5876.7 5591.2 5600.4 5605.5 5611.7 5614.6 5581.2 5643.8 5686.6 5689.6 5735.3 5621.8 5667.1 5671.4 5678.9 5687.7 5584.9 5631.8 5635.2 5644.9 5647.1 5341.2 5527.5 5586.2 5588.8 5628.2 5471.7 5544.9 5611.9 5647.7 5656.8 5467.5 5488.3 5507.2 5511.8 5518.9 17:22:02 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | [#1] ext.html Cycles:180 Average:50213.92 Median:40410.00 stddev:88077.98 (218.0%) stddev-sans-first:88246.32 17:22:02 INFO - PROCESS | 6709 | Values: 610.3 632.5 652.5 674.8 675.5 36496.8 38305.2 38308.4 38320.8 38324.8 39639.0 40248.0 40509.4 40528.2 40574.8 8483.7 8694.8 8703.7 8757.2 8767.8 8623.6 8633.9 8698.0 8756.6 8768.0 8837.6 8875.1 8940.0 8942.0 8970.2 8870.7 8903.6 8924.9 8938.3 8966.8 8688.1 8835.8 8873.1 8895.8 8901.0 40237.4 40351.4 40587.0 40688.8 40754.6 3317.1 3355.8 3359.9 3788.1 3949.8 31102.1 31151.4 31352.0 31361.0 32227.0 4426.9 4441.0 4476.7 4550.6 4585.2 293434.5 294611.0 295997.0 297095.0 298143.0 50755.0 58174.4 60916.4 60932.4 60997.0 55688.4 55955.4 56064.7 56142.7 56269.7 15534.1 15766.6 15787.0 15799.2 15803.8 11910.7 12103.2 12128.4 12185.8 12236.4 16251.9 16334.1 16416.0 16417.5 16451.8 6245.4 6410.2 6518.8 6582.9 6619.9 1070.5 1120.8 1142.7 1152.4 1157.9 30908.5 31035.5 31646.5 32118.0 32285.2 1187.9 1189.7 1208.3 1271.0 1334.2 16507.9 16576.4 16630.5 16753.0 16966.0 411345.0 414887.0 416565.9 417892.0 418225.0 55749.0 55882.0 56228.7 56464.2 56565.0 1241.3 1257.3 1257.7 1260.4 1370.4 30303.0 31226.0 31596.5 32028.0 32151.7 52848.2 55245.4 55269.4 55353.7 55438.4 270919.0 273947.0 277809.0 278949.0 280651.0 26810.6 27052.2 27210.6 27325.6 27419.5 46234.3 46753.0 47308.3 47572.5 48110.3 40468.6 40834.4 40873.2 41281.6 41636.0 39384.4 39426.8 40740.6 40816.6 41097.2 40742.2 42124.2 42479.2 42755.1 43024.4 30512.7 31924.4 32746.7 32772.8 32784.7 26225.0 26748.2 27182.3 27380.5 28061.4 17:22:02 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | [#2] jquery.html Cycles:180 Average:28698.55 Median:2360.72 stddev:88050.64 (3729.8%) stddev-sans-first:88271.97 17:22:02 INFO - PROCESS | 6709 | Values: 382.1 387.8 392.8 393.1 403.0 17398.0 19050.8 19171.7 19252.0 19288.6 16391.3 16457.3 16488.9 16548.1 17702.6 5629.7 5746.8 5784.9 5790.0 5824.0 5291.2 5545.5 5554.2 5596.5 5600.9 5570.1 5588.2 5631.4 5636.4 5658.5 5467.7 5573.6 5600.0 5602.9 5630.1 5342.4 5397.4 5405.2 5405.4 5809.9 12286.0 12327.6 12379.6 12423.9 12526.0 2272.7 2352.8 2356.4 2365.1 2392.3 9485.5 9654.8 9746.9 10637.0 12561.3 1853.6 1940.4 1947.4 1963.9 2007.7 50459.7 51256.5 60752.4 61025.7 65188.0 10472.8 10477.7 10588.6 10646.8 10787.9 14618.2 14618.6 14660.6 14769.6 14822.9 7694.8 7883.2 7998.3 8073.5 8086.8 7578.3 7638.8 7762.5 7780.1 7788.6 4556.3 4621.6 4643.2 4649.2 4700.3 1794.0 1886.4 1935.6 1949.3 2005.5 937.4 1040.8 1076.4 1129.8 1133.1 17623.2 18085.5 18312.8 18468.6 18641.2 996.3 1018.7 1041.7 1054.8 1077.4 10169.3 10270.2 10352.8 10370.3 10450.3 526688.0 533758.0 537077.0 540785.0 547112.0 89611.6 90758.0 91283.5 92343.5 92686.5 1030.8 1039.6 1052.1 1056.4 1067.1 15991.0 16241.5 16458.8 16549.8 16570.3 36681.3 36854.3 37068.4 37343.6 37692.8 46782.0 48984.5 51327.5 52779.5 53977.7 8050.0 8095.1 8272.7 8358.6 8370.8 8894.5 11739.3 12345.2 12369.6 12379.7 10349.2 10838.1 10880.6 11415.8 11586.7 5967.6 10247.5 10948.9 11150.3 11373.4 11775.5 11862.2 12240.8 12271.2 12360.4 7839.4 8124.2 8216.6 8302.6 8318.3 11127.9 11532.3 11552.7 11786.1 11848.6 17:22:02 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | [#3] mootools.html Cycles:180 Average:5262.79 Median:5179.07 stddev:2830.61 (54.7%) stddev-sans-first:2823.73 17:22:02 INFO - PROCESS | 6709 | Values: 1408.7 1482.3 1599.7 1794.1 1817.3 7060.6 7522.5 7689.6 7785.8 7820.8 7658.8 7731.8 7738.7 7773.5 7802.8 2226.8 2232.4 2248.2 2254.7 2256.5 2215.4 2225.3 2233.1 2243.0 2244.8 2196.4 2219.4 2225.4 2239.2 2254.9 2216.3 2219.1 2222.6 2234.0 2234.0 2149.6 2163.1 2164.2 2166.9 2176.5 7876.1 7925.3 7949.4 7966.2 8001.4 4632.2 4740.8 4766.5 4773.9 4777.2 3112.9 3183.9 3244.1 3272.8 3296.8 1143.1 1149.5 1153.0 1155.1 1167.4 10592.9 10653.5 10664.5 10678.3 10696.3 4107.1 4225.8 4339.2 4341.1 4355.3 9036.5 9096.7 9098.5 9107.0 9113.7 4781.3 4784.8 4787.9 4798.9 4814.0 3849.0 4434.9 4462.8 4471.1 4524.9 3630.6 3645.6 3689.9 3725.9 3769.4 1195.6 1195.8 1221.7 1231.9 1237.0 763.7 830.0 846.4 878.7 883.9 5396.2 5610.0 5738.6 5739.7 5821.5 980.8 992.6 1028.0 1049.3 1066.9 3812.8 3822.2 3946.5 3951.5 4005.5 9198.3 9461.1 9521.5 9541.0 9541.4 9496.4 9522.3 9587.9 9590.7 9631.3 7104.6 7305.3 7434.4 7447.4 7474.5 5547.1 5548.3 5585.3 5654.4 5717.2 8690.1 8770.0 8821.5 8916.6 9007.0 8759.1 8925.1 8995.3 9011.0 9142.3 6387.7 6720.6 6812.8 6871.1 6914.6 7634.6 7681.2 7699.3 7720.4 7751.7 6827.8 7171.4 7190.2 7209.4 7274.8 6928.9 6940.5 6954.8 6987.1 7015.7 6240.8 6242.7 6256.6 6348.4 6398.0 5074.8 5122.9 5169.3 5188.8 5266.4 5012.2 5066.1 5066.9 5121.6 5123.9 17:22:02 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | [#4] prototype.html Cycles:180 Average:5215.76 Median:5993.81 stddev:1610.21 (26.9%) stddev-sans-first:1571.87 17:22:02 INFO - PROCESS | 6709 | Values: 298.9 304.1 306.2 306.3 308.8 5918.1 6016.9 6021.2 6026.3 6047.7 5759.3 5767.5 5934.7 5954.7 5961.8 4173.1 4311.3 4474.2 4474.4 4506.0 4464.3 4489.1 4498.4 4500.2 4513.9 4406.6 4444.9 4448.1 4468.7 4479.1 4369.5 4437.4 4443.6 4471.6 4474.0 3852.2 3863.0 3864.4 3874.2 3878.9 5737.0 5765.7 5774.1 5785.8 5811.1 5011.7 5068.7 5083.4 5105.3 5157.1 6203.0 6217.8 6234.8 6236.2 6262.6 4238.6 4249.1 4249.9 4268.1 4271.7 6057.3 6391.8 6409.3 6409.9 6443.3 4211.2 4342.5 4354.4 4359.0 4361.2 4351.2 4411.7 4415.9 4424.0 4442.3 5135.1 5151.2 5151.4 5174.9 5179.5 6223.4 6250.7 6263.4 6266.7 6270.0 1492.6 1515.2 1538.2 1538.9 1538.9 958.8 1002.2 1012.0 1032.4 1032.7 5910.9 5943.4 5949.5 5998.4 6031.6 6398.7 6414.0 6434.2 6436.5 6463.5 5839.2 5951.3 5992.9 5998.5 6026.4 3374.7 3411.9 3414.2 3420.7 3424.3 6499.8 6549.5 6573.6 6624.8 6706.3 6516.6 6519.4 6551.8 6571.1 6587.0 6518.0 6629.5 6638.7 6692.7 6865.7 6562.1 6565.4 6577.9 6579.5 6594.3 6153.5 6446.1 6451.5 6495.8 6499.4 6769.4 6780.3 6788.7 6798.3 6830.5 4195.6 4248.4 4259.3 4265.7 4267.7 6348.6 6549.3 6554.3 6584.8 6611.5 6351.3 6366.4 6373.9 6395.6 6422.0 6030.7 6261.6 6363.5 6371.7 6395.5 5994.7 6067.1 6249.3 6254.3 6263.8 6339.7 6409.9 6417.2 6417.4 6447.4 6061.6 6200.8 6231.9 6257.4 6276.7 17:22:02 INFO - PROCESS | 6709 | 17:22:02 INFO - PROCESS | 6709 | [#5] yui.html Cycles:180 Average:14824.26 Median:44829.16 stddev:17206.78 (38.4%) stddev-sans-first:17222.74 17:22:02 INFO - PROCESS | 6709 | Values: 782.4 788.8 810.5 839.6 844.1 13921.6 13929.9 13943.2 13949.3 14145.4 13227.8 13331.5 13344.2 13348.4 13349.1 662.6 762.1 789.8 791.4 799.8 794.5 798.0 799.6 802.2 804.1 798.5 807.3 812.6 813.0 813.5 799.5 811.3 814.6 814.6 817.1 592.7 596.3 596.7 600.0 601.2 13951.4 14054.9 14107.2 14118.2 14136.6 13901.0 14093.3 14192.8 14254.8 14321.0 11245.2 11254.8 11294.3 11450.9 11512.9 3893.8 3950.6 3991.6 3999.0 4131.8 56340.0 57291.7 58560.1 58566.1 58625.7 9453.9 9568.8 10721.6 10897.5 10973.2 19125.6 19244.2 19459.0 19520.2 19547.8 8232.0 8297.8 8335.8 8415.3 8637.0 4571.5 4894.0 4907.6 4979.4 5091.8 3206.9 3255.9 3268.0 3270.3 3307.3 580.7 639.2 648.2 651.0 651.5 636.0 687.7 715.2 721.4 743.6 8945.5 9076.5 9148.5 9156.0 9472.8 689.0 701.6 712.2 712.9 720.7 4287.9 4410.8 4413.3 4438.9 4450.1 60721.4 61452.0 62228.0 62778.7 63349.4 54008.5 55463.4 55779.2 55969.0 56268.2 44700.3 44958.0 50618.0 51145.7 51485.5 8872.9 9062.2 9191.6 9487.1 9585.3 31766.0 32269.5 33051.7 33502.7 33921.3 41462.0 44271.8 45730.1 46676.0 46921.0 11876.6 11881.8 11930.4 12011.9 12224.3 12849.9 13235.3 13274.8 13324.1 13670.5 12930.3 12939.8 13048.3 13110.9 13121.1 11268.8 11318.9 11500.9 11894.6 12123.9 11952.2 12899.0 12988.5 13122.1 13452.9 10703.8 10805.9 10950.4 11064.3 11284.9 10793.2 11303.7 11530.4 11601.5 11799.5 17:22:02 INFO - PROCESS | 6709 | -------- Summary: end -------- 17:22:02 INFO - PROCESS | 6709 | 17:22:03 INFO - TEST-INFO | 6709: exit 0 17:22:03 INFO - TEST-OK | dromaeo_css | took 1110450ms 17:22:03 INFO - TEST-START | kraken 17:22:03 INFO - operating with platform_type : linux_ 17:22:03 INFO - Initialising browser for kraken test... 17:22:03 INFO - TEST-INFO | started process 6948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZpiSUs/profile http://localhost:35130/getInfo.html) 17:22:07 INFO - PROCESS | 6948 | 17:22:07 INFO - PROCESS | 6948 | (process:7019): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:22:07 INFO - PROCESS | 6948 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:22:08 INFO - PROCESS | 6948 | __metrics Screen width/height:1600/1200 17:22:08 INFO - PROCESS | 6948 | colorDepth:24 17:22:08 INFO - PROCESS | 6948 | Browser inner width/height: 1024/697 17:22:08 INFO - PROCESS | 6948 | __metrics 17:22:09 ERROR - PROCESS | 6948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:22:10 INFO - TEST-INFO | 6948: exit 0 17:22:10 INFO - Browser initialized. 17:22:10 INFO - Running cycle 1/1 for kraken test... 17:22:10 INFO - TEST-INFO | started process 7070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZpiSUs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:12 INFO - PROCESS | 7070 | 17:22:12 INFO - PROCESS | 7070 | (process:7130): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:22:22 INFO - PROCESS | 7070 | RSS: Main: 162803712 17:22:22 INFO - PROCESS | 7070 | 17:22:24 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35130/tests/kraken/driver.html?testName=audio-beat-detection) 17:22:25 INFO - PROCESS | 7070 | RSS: Main: 167145472 17:22:25 INFO - PROCESS | 7070 | 17:22:28 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35130/tests/kraken/driver.html?testName=audio-dft) 17:22:28 INFO - PROCESS | 7070 | RSS: Main: 170508288 17:22:28 INFO - PROCESS | 7070 | 17:22:31 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35130/tests/kraken/driver.html?testName=audio-fft) 17:22:32 INFO - PROCESS | 7070 | RSS: Main: 160313344 17:22:32 INFO - PROCESS | 7070 | 17:22:34 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35130/tests/kraken/driver.html?testName=audio-oscillator) 17:22:35 INFO - PROCESS | 7070 | RSS: Main: 160817152 17:22:35 INFO - PROCESS | 7070 | 17:22:37 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35130/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:22:38 INFO - PROCESS | 7070 | RSS: Main: 162598912 17:22:38 INFO - PROCESS | 7070 | 17:22:41 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35130/tests/kraken/driver.html?testName=imaging-darkroom) 17:22:41 INFO - PROCESS | 7070 | RSS: Main: 163004416 17:22:41 INFO - PROCESS | 7070 | 17:22:45 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35130/tests/kraken/driver.html?testName=imaging-desaturate) 17:22:45 INFO - PROCESS | 7070 | RSS: Main: 162832384 17:22:45 INFO - PROCESS | 7070 | 17:22:48 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35130/tests/kraken/driver.html?testName=json-parse-financial) 17:22:49 INFO - PROCESS | 7070 | RSS: Main: 165470208 17:22:49 INFO - PROCESS | 7070 | 17:22:50 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35130/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:22:51 INFO - PROCESS | 7070 | RSS: Main: 165675008 17:22:51 INFO - PROCESS | 7070 | 17:22:53 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35130/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:22:53 INFO - PROCESS | 7070 | RSS: Main: 165527552 17:22:53 INFO - PROCESS | 7070 | 17:22:55 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35130/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:22:56 INFO - PROCESS | 7070 | RSS: Main: 166301696 17:22:56 INFO - PROCESS | 7070 | 17:22:59 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:22:59 INFO - PROCESS | 7070 | RSS: Main: 166273024 17:22:59 INFO - PROCESS | 7070 | 17:23:02 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:23:03 INFO - PROCESS | 7070 | RSS: Main: 166449152 17:23:03 INFO - PROCESS | 7070 | 17:23:04 INFO - PROCESS | 7070 | Cycle 1(1): loaded http://localhost:35130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35130/tests/kraken/driver.html?testName=ai-astar) 17:23:05 INFO - PROCESS | 7070 | RSS: Main: 167723008 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | __start_tp_report 17:23:05 INFO - PROCESS | 7070 | _x_x_mozilla_page_load 17:23:05 INFO - PROCESS | 7070 | _x_x_mozilla_page_load_details 17:23:05 INFO - PROCESS | 7070 | |i|pagename|runs| 17:23:05 INFO - PROCESS | 7070 | |0;ai-astar;110;106;110;111;110;122;110;112;111;109 17:23:05 INFO - PROCESS | 7070 | |1;audio-beat-detection;152;129;157;180;132;159;155;129;185;129 17:23:05 INFO - PROCESS | 7070 | |2;audio-dft;163;163;163;162;162;165;166;166;170;162 17:23:05 INFO - PROCESS | 7070 | |3;audio-fft;76;75;73;166;75;75;76;77;152;77 17:23:05 INFO - PROCESS | 7070 | |4;audio-oscillator;93;92;156;94;94;92;150;93;93;162 17:23:05 INFO - PROCESS | 7070 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;117 17:23:05 INFO - PROCESS | 7070 | |6;imaging-darkroom;147;146;146;146;147;147;148;147;148;146 17:23:05 INFO - PROCESS | 7070 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;95;96 17:23:05 INFO - PROCESS | 7070 | |8;json-parse-financial;59;58;58;58;59;63;62;73;57;56 17:23:05 INFO - PROCESS | 7070 | |9;json-stringify-tinderbox;62;62;61;61;62;62;61;62;62;62 17:23:05 INFO - PROCESS | 7070 | |10;stanford-crypto-aes;84;81;83;81;85;83;83;82;84;82 17:23:05 INFO - PROCESS | 7070 | |11;stanford-crypto-ccm;131;129;135;139;139;136;132;130;167;142 17:23:05 INFO - PROCESS | 7070 | |12;stanford-crypto-pbkdf2;169;172;168;167;168;169;169;171;167;163 17:23:05 INFO - PROCESS | 7070 | |13;stanford-crypto-sha256-iterative;70;70;70;70;69;67;68;73;68;66 17:23:05 INFO - PROCESS | 7070 | __end_tp_report 17:23:05 INFO - PROCESS | 7070 | __start_cc_report 17:23:05 INFO - PROCESS | 7070 | _x_x_mozilla_cycle_collect,819 17:23:05 INFO - PROCESS | 7070 | __end_cc_report 17:23:05 INFO - PROCESS | 7070 | __startTimestamp1460679785171__endTimestamp 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | ------- Summary: start ------- 17:23:05 INFO - PROCESS | 7070 | Number of tests: 14 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:4.15 (3.8%) stddev-sans-first:4.38 17:23:05 INFO - PROCESS | 7070 | Values: 110.0 106.0 110.0 111.0 110.0 122.0 110.0 112.0 111.0 109.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:156.00 stddev:20.89 (13.4%) stddev-sans-first:22.15 17:23:05 INFO - PROCESS | 7070 | Values: 152.0 129.0 157.0 180.0 132.0 159.0 155.0 129.0 185.0 129.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.57 (1.6%) stddev-sans-first:2.69 17:23:05 INFO - PROCESS | 7070 | Values: 163.0 163.0 163.0 162.0 162.0 165.0 166.0 166.0 170.0 162.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#3] audio-fft Cycles:10 Average:92.20 Median:75.50 stddev:35.38 (46.9%) stddev-sans-first:37.04 17:23:05 INFO - PROCESS | 7070 | Values: 76.0 75.0 73.0 166.0 75.0 75.0 76.0 77.0 152.0 77.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#4] audio-oscillator Cycles:10 Average:111.90 Median:93.00 stddev:30.57 (32.9%) stddev-sans-first:31.65 17:23:05 INFO - PROCESS | 7070 | Values: 93.0 92.0 156.0 94.0 94.0 92.0 150.0 93.0 93.0 162.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:23:05 INFO - PROCESS | 7070 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:23:05 INFO - PROCESS | 7070 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 148.0 147.0 148.0 146.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:23:05 INFO - PROCESS | 7070 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.00 stddev:4.95 (8.4%) stddev-sans-first:5.22 17:23:05 INFO - PROCESS | 7070 | Values: 59.0 58.0 58.0 58.0 59.0 63.0 62.0 73.0 57.0 56.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 17:23:05 INFO - PROCESS | 7070 | Values: 62.0 62.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.32 (1.6%) stddev-sans-first:1.32 17:23:05 INFO - PROCESS | 7070 | Values: 84.0 81.0 83.0 81.0 85.0 83.0 83.0 82.0 84.0 82.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:137.50 stddev:11.07 (8.0%) stddev-sans-first:11.44 17:23:05 INFO - PROCESS | 7070 | Values: 131.0 129.0 135.0 139.0 139.0 136.0 132.0 130.0 167.0 142.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:169.00 stddev:2.45 (1.5%) stddev-sans-first:2.59 17:23:05 INFO - PROCESS | 7070 | Values: 169.0 172.0 168.0 167.0 168.0 169.0 169.0 171.0 167.0 163.0 17:23:05 INFO - PROCESS | 7070 | 17:23:05 INFO - PROCESS | 7070 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:1.97 (2.8%) stddev-sans-first:2.06 17:23:05 INFO - PROCESS | 7070 | Values: 70.0 70.0 70.0 70.0 69.0 67.0 68.0 73.0 68.0 66.0 17:23:05 INFO - PROCESS | 7070 | -------- Summary: end -------- 17:23:05 INFO - PROCESS | 7070 | 17:23:06 INFO - TEST-INFO | 7070: exit 0 17:23:06 INFO - TEST-OK | kraken | took 62972ms 17:23:06 INFO - SUITE-END | took 1173s 17:23:06 INFO - Completed test suite (00:19:33) 17:23:06 INFO - javascript benchmark 17:23:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.5250212468127, 3181.793183443076, 3212.742980561555, 3222.1783445221463, 3226.2902161524457, 5335.5198032177095, 5363.088274993251, 5390.083685773418, 5394.136938089897, 5440.836774896749, 5343.599230057752, 5364.222187782769, 5386.0, 5389.434109418514, 5515.531179849708, 4814.422269327685, 4840.709557426548, 4907.067657145149, 4913.115639184964, 4942.085714142877, 4784.258439941815, 4793.4487533933525, 4833.516648335173, 4871.829485967992, 4876.804927802884, 4872.78072486739, 4874.707517548941, 4880.121578115938, 4909.631777616693, 4909.656324057318, 4924.8768780780765, 4925.802967881316, 4932.506749325074, 4948.87627809304, 4953.975230123862, 4779.80880764769, 4822.831200907952, 4896.075748344472, 4902.803887844482, 4941.728204948727, 5246.973765131188, 5251.291075704769, 5283.841484755425, 5290.761915713802, 5303.522682958553, 5675.2054712340305, 5681.289838770153, 5702.144678298247, 5726.713664316809, 5734.8279551613105, 5597.944020559783, 5717.9714101429645, 5779.942200578024, 5810.622309549908, 5872.354041055481, 5289.391719952217, 5325.946740532584, 5339.332583427072, 5347.572194224453, 5354.14333706609, 5739.7704091836695, 5751.741171647286, 5769.336526299446, 5808.380250112085, 5821.039528477754, 5553.50018498329, 5629.0149223885655, 5666.150077488327, 5677.574181936371, 5714.599978001583, 5667.744951477193, 5668.688222147739, 5675.1770993205755, 5676.858078548069, 5683.54531637468, 5521.254630624814, 5601.887962240732, 5630.296212973379, 5643.125315576092, 5653.293338332708, 5586.301712285965, 5695.515881150149, 5744.253247077853, 5760.855978600484, 5816.331121921034, 4302.698811083194, 4365.956340436555, 4368.0, 4369.737815731066, 4409.33859921008, 3822.5986271441097, 3825.923481530354, 3827.6937844972335, 3861.7489863158803, 3864.942025869614, 5337.919931201035, 5369.4362091980565, 5382.515573598395, 5391.757370918318, 5411.485908838654, 5695.060315048054, 5711.400302968212, 5716.485516303553, 5719.628224165416, 5723.713814309268, 5353.946460535422, 5358.303420555303, 5414.648047876875, 5444.700541470257, 5465.480779325958, 4857.708537487762, 4858.732769697701, 4883.4628190898975, 4891.364122664031, 4923.5814955729165, 5773.8556536086935, 5873.500752436005, 5880.588358814842, 5914.651098137316, 5940.168376427304, 5696.829095127153, 5701.059325211294, 5723.370429252779, 5761.366249712612, 5764.3371012332445, 5832.358440571618, 5862.443067908542, 5870.7945221918735, 5871.1486834407915, 5876.735546900485, 5591.245181900392, 5600.439956004367, 5605.467480589337, 5611.7194140292, 5614.606977511535, 5581.162825576196, 5643.83068507929, 5686.60193786431, 5689.573282003784, 5735.283089613798, 5621.80323688669, 5667.064934285797, 5671.376148623565, 5678.914816277676, 5687.715614219355, 5584.888302234014, 5631.802886898939, 5635.154726791015, 5644.915326270027, 5647.124695672177, 5341.172118321666, 5527.50252477279, 5586.16207568868, 5588.832335029955, 5628.240187574625, 5471.671699698031, 5544.916826247691, 5611.859703507445, 5647.6893770843, 5656.773729050792, 5467.507924286833, 5488.25908502363, 5507.173923911445, 5511.834644960658, 5518.862028449321], "value": 5268.675558396325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.3255902228038, 632.4813652804701, 652.4812773844792, 674.8312921769558, 675.5102550650779, 36496.81751591245, 38305.233895322075, 38308.42537361935, 38320.80839595802, 38324.80837595811, 39639.0, 40248.0, 40509.392359114565, 40528.18943621126, 40574.797126014404, 8483.745487635366, 8694.782630434258, 8703.651853925867, 8757.168069033432, 8767.780805479882, 8623.611937462798, 8633.870491942625, 8697.95651021744, 8756.60595273211, 8768.0, 8837.558122093902, 8875.06811784763, 8939.95530022349, 8942.0, 8970.237529809974, 8870.689525866595, 8903.599338029804, 8924.8661270081, 8938.284937205008, 8966.820663586757, 8688.131186881325, 8835.823283534357, 8873.068327825615, 8895.822083558358, 8901.0, 40237.39643905344, 40351.39472907909, 40587.0, 40688.79655601703, 40754.59245407538, 3317.137544238491, 3355.8154301513405, 3359.932801343984, 3788.1287303920253, 3949.7984391445107, 31102.066937991898, 31151.37697246065, 31352.0, 31361.0, 32227.033189004367, 4426.889327766799, 4440.977795111036, 4476.686631935766, 4550.613197878184, 4585.174668559658, 293434.53282733663, 294611.0, 295997.0, 297095.0, 298143.0, 50754.98490030179, 58174.41825581775, 60916.39083609196, 60932.39067609267, 60997.0, 55688.443115569135, 55955.440445595836, 56064.71967640217, 56142.6664466875, 56269.71865140648, 15534.145621990672, 15766.605834854221, 15787.0, 15799.21003949821, 15803.762943555856, 11910.702232444084, 12103.213291136224, 12128.393580321124, 12185.756284874253, 12236.449359778831, 16251.918740406223, 16334.101624410772, 16416.0, 16417.507474775775, 16451.83548164527, 6245.437910588069, 6410.1987251593555, 6518.804435866931, 6582.868342633121, 6619.867602648016, 1070.5343175718588, 1120.843081968525, 1142.708609304622, 1152.3949926288765, 1157.9305241685527, 30908.53637195444, 31035.534466983012, 31646.525302120488, 32118.0, 32285.192870178435, 1187.9406029698653, 1189.7323102301914, 1208.3112625803208, 1270.9682257943625, 1334.159479527891, 16507.9302121499, 16576.419825306057, 16630.50108496747, 16753.0, 16966.0, 411345.0, 414887.0, 416565.9171704122, 417892.0, 418225.0, 55749.0, 55882.0, 56228.71885640546, 56464.15303770447, 56565.0, 1241.2924632959307, 1257.2645002673355, 1257.6792917805901, 1260.4454040222272, 1370.390176371525, 30303.0, 31226.0, 31596.526052109697, 32028.0, 32151.678483215805, 52848.207276890105, 55245.44754552403, 55269.44730552643, 55353.723231383585, 55438.445615544944, 270919.0, 273947.0, 277809.0, 278949.0, 280651.0, 26810.59784103201, 27052.188434347, 27210.591841122794, 27325.590116148673, 27419.451610968066, 46234.30648540207, 46753.0, 47308.2903756437, 47572.52427475681, 48110.27834582414, 40468.59531404766, 40834.38748418835, 40873.182536349705, 41281.58718412898, 41636.0, 39384.40923386209, 39426.80286598549, 40740.59259407368, 40816.591834082465, 41097.178056438104, 40742.1851562973, 42124.15751685011, 42479.150416990866, 42755.144897101265, 43024.354634681134, 30512.694873051874, 31924.36151277008, 32746.672533274363, 32772.83613581917, 32784.67215327816, 26225.0, 26748.19755407341, 27182.32044198832, 27380.452390951672, 28061.438771224053], "value": 19245.76526896909, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.09634215081326, 387.8293550837631, 392.844826293614, 393.052742889636, 402.95768944260834, 17398.0, 19050.809491905078, 19171.712424313646, 19251.99999999998, 19288.614227715454, 16391.262393192304, 16457.34170633176, 16488.917555412205, 16548.089855058, 17702.64594708105, 5629.7185140743, 5746.827595172131, 5784.855378615526, 5790.0, 5823.970880145594, 5291.2327712481665, 5545.500904918556, 5554.166874968747, 5596.496315331619, 5600.915986260209, 5570.108782594785, 5588.245586845765, 5631.408702086263, 5636.408177141403, 5658.490735833774, 5467.726613669321, 5573.554115670737, 5599.972000139994, 5602.943970560304, 5630.071038278679, 5342.439043900412, 5397.433269506684, 5405.18922161675, 5405.432429594875, 5809.88380232393, 12286.0, 12327.630171094792, 12379.62861114168, 12423.937880310541, 12526.0, 2272.715910511186, 2352.752960939094, 2356.363781778927, 2365.077619728307, 2392.2583998960376, 9485.478298693639, 9654.806903861954, 9746.853797193047, 10637.0, 12561.309127997956, 1853.629274145163, 1940.3596813051659, 1947.3573720672287, 1963.8821670699804, 2007.7088822120857, 50459.74770126126, 51256.48743512554, 60752.39247607512, 61025.694871525804, 65188.0, 10472.790544189074, 10477.747284333906, 10588.629397971034, 10646.787064258826, 10787.946060269649, 14618.195999220145, 14618.63453413652, 14660.633484162769, 14769.63075923089, 14822.851771482363, 7694.769156925301, 7883.2116788321855, 7998.320142787812, 8073.515589064675, 8086.83826323482, 7578.280063393969, 7638.770836874903, 7762.534247945141, 7780.14418413974, 7788.585538483088, 4556.270996640522, 4621.56731413263, 4643.164230438553, 4649.18639238132, 4700.341952126705, 1793.9635819406335, 1886.3963531670008, 1935.632229876319, 1949.2787668562723, 2005.4585261979184, 937.4328531238502, 1040.7918416316768, 1076.359566058194, 1129.7627498225465, 1133.0652211925194, 17623.206955687026, 18085.457436276934, 18312.81687183138, 18468.630627387378, 18641.161147748382, 996.2826764729383, 1018.6994836523244, 1041.7239431550645, 1054.836500342448, 1077.4020418667558, 10169.288149829588, 10270.178385729123, 10352.792944141225, 10370.325928814604, 10450.268481206243, 526688.0, 533758.0, 537077.0, 540785.0, 547112.0, 89611.55194224117, 90758.0, 91283.54358228167, 92343.5382823095, 92686.53656731673, 1030.8041472120274, 1039.594558122333, 1052.1425038593675, 1056.3503445381189, 1067.0716476665195, 15991.0, 16241.51275461738, 16458.83541164621, 16549.751753723944, 16570.254338555034, 36681.266374672894, 36854.26291474102, 37068.44397333988, 37343.6265637351, 37692.81153594214, 46782.0, 48984.510154897995, 51327.48672513227, 52779.472205278995, 53977.73011134919, 8050.033995920527, 8095.069067057364, 8272.710455134042, 8358.62386192635, 8370.832583348178, 8894.4663320201, 11739.295642261492, 12345.197562158432, 12369.567065152676, 12379.690507737017, 10349.223808214263, 10838.078763305208, 10880.619178328721, 11415.828762568734, 11586.652400428, 5967.6121052131475, 10247.487625618838, 10948.945255273673, 11150.330980141218, 11373.431328433711, 11775.470103845519, 11862.22895511789, 12240.816387754012, 12271.202371845802, 12360.38198090074, 7839.412044096602, 8124.187581241828, 8216.630251638571, 8302.626381812712, 8318.251357377865, 11127.944360278147, 11532.25040372373, 11552.711182220512, 11786.116041296766, 11848.585299514476], "value": 8732.46247592622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.7393832141054, 1482.251463011179, 1599.6560739441024, 1794.1298470241923, 1817.3094224194804, 7060.576365418078, 7522.5110367826055, 7689.615519224044, 7785.805354866138, 7820.804479887998, 7658.770236892902, 7731.845363092749, 7738.729144479944, 7773.494722843011, 7802.8439431211345, 2226.755056943735, 2232.363776323748, 2248.15694114707, 2254.695616091823, 2256.4584499720113, 2215.3907675389237, 2225.321277010511, 2233.095596283508, 2243.0354947372703, 2244.842860999731, 2196.406970118067, 2219.3896678413403, 2225.3880182949656, 2239.2162743039967, 2254.86470811751, 2216.2907869481774, 2219.0901730290584, 2222.622154233792, 2234.0393630738777, 2234.0393630738777, 2149.6345621244427, 2163.0590693048575, 2164.166795783635, 2166.9024893879814, 2176.4994051368117, 7876.05487341517, 7925.3263472604895, 7949.403794715419, 7966.203379662045, 8001.359891208747, 4632.166210082184, 4740.810367585293, 4766.475687674388, 4773.928391074137, 4777.211760059586, 3112.863804711287, 3183.8567264473154, 3244.0916543367894, 3272.803631782077, 3296.785708928912, 1143.1026644084436, 1149.4597539156582, 1152.9538818447252, 1155.1394211312627, 1167.357953125786, 10592.894071059267, 10653.467326633638, 10664.466776661136, 10678.252522323362, 10696.251262411633, 4107.116969851437, 4225.809838557211, 4339.240632889232, 4341.131773645284, 4355.2813785725, 9036.548172591476, 9096.681616143404, 9098.545072746336, 9107.0, 9113.681021164228, 4781.330613714083, 4784.760761961888, 4787.928181077286, 4798.904021919542, 4814.0, 3848.99926019237, 4434.889127771767, 4462.799174037176, 4471.083427897273, 4524.932126018112, 3630.5824830144343, 3645.5989841117457, 3689.94465083024, 3725.8882233533036, 3769.3780526212868, 1195.611426286443, 1195.7847587434346, 1221.6884694403047, 1231.8891299782883, 1237.0412929979339, 763.7097902796902, 829.9625468164794, 846.4413487098609, 878.6792820620427, 883.8718385834018, 5396.163594642837, 5609.971950140305, 5738.569607279471, 5739.684317362585, 5821.505172060338, 980.8181141724206, 992.5781542844262, 1028.0387837372082, 1049.317943336837, 1066.9466526673634, 3812.8284227209842, 3822.2164456286396, 3946.5264168299987, 3951.4863067801575, 4005.539362973237, 9198.310126740522, 9461.148496635336, 9521.523923803783, 9541.045895410403, 9541.379810312308, 9496.382735122195, 9522.333436659506, 9587.856182157273, 9590.712278631652, 9631.325807193569, 7104.573725576585, 7305.3425191732995, 7434.405247580181, 7447.44144189188, 7474.476786624993, 5547.089302042132, 5548.334199895877, 5585.273914391103, 5654.434556544313, 5717.171010203414, 8690.130986901511, 8769.956150219208, 8821.470711757314, 8916.55417229149, 9007.0, 8759.080296568769, 8925.107489251022, 8995.280377569648, 9010.954945225232, 9142.314326425412, 6387.712552935036, 6720.630365329954, 6812.795616131524, 6871.072405225431, 6914.619695916773, 7634.580098094658, 7681.1934746850775, 7699.307062364414, 7720.382369410546, 7751.689932402641, 6827.761028363983, 7171.390431813355, 7190.245024272376, 7209.35115839577, 7274.781756547312, 6928.930710692828, 6940.514164008673, 6954.79135625932, 6987.1266091738535, 7015.6842942066705, 6240.812775616739, 6242.65665388408, 6256.5620406572925, 6348.396902294275, 6397.96801015992, 5074.82238121664, 5122.923156152735, 5169.327987361619, 5188.818391356284, 5266.420693723764, 5012.198048312398, 5066.08810414129, 5066.898662026812, 5121.641485096007, 5123.949590334048], "value": 4304.993603385903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.94768415527284, 304.06045319961316, 306.1901271137839, 306.2756580686676, 308.84094691234003, 5918.1122831575285, 6016.909746353808, 6021.217241758565, 6026.337102918681, 6047.697615119248, 5759.337676167242, 5767.452092051259, 5934.744796977154, 5954.70226488675, 5961.761529538813, 4173.123644034748, 4311.3101903695415, 4474.217012022883, 4474.351219073249, 4505.994832299628, 4464.308032255006, 4489.079738653584, 4498.437695288089, 4500.167469018242, 4513.864584062483, 4406.581374769392, 4444.911101777962, 4448.088141930896, 4468.664850136237, 4479.081788233404, 4369.453818272716, 4437.4009508716235, 4443.644508439334, 4471.6199123074575, 4473.964346222461, 3852.210296889131, 3863.014931192556, 3864.381698928158, 3874.2057878134915, 3878.8642397516232, 5737.049403202889, 5765.682887441189, 5774.105013722879, 5785.846713541088, 5811.070228763378, 5011.699298042129, 5068.695878247317, 5083.415407228142, 5105.336306280197, 5157.149070403379, 6202.968985155046, 6217.782377616762, 6234.781782637586, 6236.18929539157, 6262.5929314594405, 4238.639715624176, 4249.0652056547815, 4249.915001699948, 4268.103698223377, 4271.6582673386365, 6057.273127224717, 6391.776287829904, 6409.327020662809, 6409.903851442232, 6443.259025212114, 4211.178820130107, 4342.478902531717, 4354.368616550582, 4359.0, 4361.171377438277, 4351.19502891966, 4411.735295882193, 4415.873952142183, 4424.0, 4442.2892337225885, 5135.101357262539, 5151.201563757623, 5151.356080489939, 5174.922376164361, 5179.482051794866, 6223.439890409885, 6250.656213908188, 6263.404976527223, 6266.686665666698, 6270.0, 1492.5820770184366, 1515.2272341105895, 1538.2462593329187, 1538.9307481163376, 1538.9384424623113, 958.7507248115401, 1002.2082554781641, 1011.9797604047877, 1032.3547782635853, 1032.6695457453543, 5910.940890591125, 5943.375945525744, 5949.494292985059, 5998.3701711320555, 6031.638101713911, 6398.712057957403, 6413.973764197706, 6434.163558737334, 6436.485081193493, 6463.547551671338, 5839.240898683144, 5951.315598706117, 5992.880142397127, 5998.520118390518, 6026.427489388501, 3374.6625337466057, 3411.863525458954, 3414.1904790461094, 3420.6579342066093, 3424.3493736190544, 6499.805005849832, 6549.476041916635, 6573.605583664996, 6624.8343791405605, 6706.26231114577, 6516.609003459807, 6519.380658837403, 6551.770688025897, 6571.145751052428, 6587.0, 6517.967410162919, 6629.5359324846795, 6638.668066596748, 6692.665366731644, 6865.661196066819, 6562.114114594468, 6565.441937435371, 6577.868442631025, 6579.4736421087155, 6594.340141221668, 6153.476954458921, 6446.129772480843, 6451.451626611791, 6495.772647957298, 6499.38255865692, 6769.390754831892, 6780.32196780318, 6788.66056697173, 6798.286179951232, 6830.521863469509, 4195.622393984556, 4248.426462427533, 4259.275923093143, 4265.680073994401, 4267.743935363888, 6348.604444621937, 6549.279579246374, 6554.344565543408, 6584.8024559263295, 6611.537192396486, 6351.30135685065, 6366.376573973607, 6373.904391434039, 6395.552311338161, 6422.0, 6030.678188897218, 6261.592996455216, 6363.454618152776, 6371.74513019474, 6395.520335974914, 5994.730237139252, 6067.12026756109, 6249.34381889895, 6254.28075771274, 6263.78076767311, 6339.746410143543, 6409.87827130241, 6417.197850268716, 6417.39034791694, 6447.387498187664, 6061.605995610271, 6200.782972595937, 6231.875362492816, 6257.405546473078, 6276.6547839869245], "value": 4678.462125553635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.3662833105187, 788.7909703928458, 810.4853418079522, 839.6263662670115, 844.1347618690837, 13921.58235252944, 13929.860701392983, 13943.233122178277, 13949.302534873254, 14145.363458644348, 13227.801582976263, 13331.53339633113, 13344.199348039125, 13348.399322030507, 13349.132306400077, 662.6024385368764, 762.0969151555397, 789.7512283630653, 791.3708601661692, 799.8320352725906, 794.4756460735915, 797.972070977516, 799.596203917024, 802.2018091998469, 804.0994086622991, 798.4530596541359, 807.2976510435929, 812.5733989655448, 813.0446725098016, 813.515958004986, 799.5282783157936, 811.2617518058568, 814.5723495165086, 814.6049166154411, 817.0685418622775, 592.7006861534941, 596.2755252368349, 596.7344531683402, 599.9550033747487, 601.1913975702673, 13951.372188251553, 14054.859451405457, 14107.224102674349, 14118.223497707622, 14136.646583835383, 13901.0, 14093.2953352333, 14192.787108193384, 14254.786178207336, 14321.0, 11245.212835101545, 11254.831177532344, 11294.265872718248, 11450.854914508482, 11512.942435287854, 3893.8247778849736, 3950.5654378018394, 3991.5808840071663, 3998.960010399888, 4131.834726610932, 56340.0, 57291.71354143203, 58560.12159817649, 58566.12150817741, 58625.706871465794, 9453.858192127123, 9568.780565148758, 10721.571137154426, 10897.509612067475, 10973.231873768918, 19125.61748765017, 19244.23023079061, 19459.0, 19520.21919123219, 19547.804521954884, 8231.95884020576, 8297.792555186168, 8335.791605209919, 8415.284700800377, 8637.0, 4571.457046043412, 4893.975530122327, 4907.55831975124, 4979.377577802775, 5091.7963281469065, 3206.8556914938886, 3255.9348813023607, 3268.0, 3270.3132342207928, 3307.2724000719804, 580.7067430947429, 639.2424976402978, 648.160631981585, 650.9511786616023, 651.5146216069058, 635.9682015899186, 687.6767919078026, 715.2025491576958, 721.3760097515716, 743.6319022084103, 8945.46327220369, 9076.500792456478, 9148.542572871464, 9155.954220228856, 9472.763180920532, 688.9655517224119, 701.6281370873445, 712.1809918593659, 712.8788106021989, 720.657687598397, 4287.935680964788, 4410.845620403271, 4413.293872980308, 4438.933415998763, 4450.132224216247, 60721.39278607246, 61452.0, 62228.0, 62778.68610656918, 63349.36650633527, 54008.45991540113, 55463.445365546635, 55779.16331255034, 55969.0, 56268.15597766037, 44700.3294950576, 44957.999999999345, 50618.0, 51145.7442712784, 51485.48514514807, 8872.866906996529, 9062.229710474683, 9191.632334706537, 9487.146156845916, 9585.281103917374, 31766.0, 32269.51595726019, 33051.66948330486, 33502.66497334996, 33921.32157356889, 41462.0, 44271.77864110659, 45730.08539829118, 46676.0, 46921.0, 11876.643700688994, 11881.82177267359, 11930.4034798258, 12011.879881201075, 12224.327661978676, 12849.87150128524, 13235.272060036405, 13274.77011295023, 13324.133931294435, 13670.453181872614, 12930.288834114213, 12939.805902911276, 13048.282344471145, 13110.868891310965, 13121.147125436815, 11268.7746245073, 11318.94340528292, 11500.94249528747, 11894.583689570823, 12123.878321293914, 11952.223105498115, 12899.0, 12988.480460781462, 13122.08145429849, 13452.865471345161, 10703.839442408525, 10805.891941080488, 10950.397728124712, 11064.28082174656, 11284.9435752824, 10793.244472886823, 11303.660890173307, 11530.423478826193, 11601.477933493183, 11799.528018879491], "value": 6708.677277323339, "unit": "score"}], "name": "dromaeo_css", "value": 7019.74456532334, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 110.0, 111.0, 110.0, 122.0, 110.0, 112.0, 111.0, 109.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 157.0, 180.0, 132.0, 159.0, 155.0, 129.0, 185.0, 129.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 162.0, 165.0, 166.0, 166.0, 170.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 73.0, 166.0, 75.0, 75.0, 76.0, 77.0, 152.0, 77.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 156.0, 94.0, 94.0, 92.0, 150.0, 93.0, 93.0, 162.0], "value": 111.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 59.0, 63.0, 62.0, 73.0, 57.0, 56.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 81.0, 85.0, 83.0, 83.0, 82.0, 84.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 135.0, 139.0, 139.0, 136.0, 132.0, 130.0, 167.0, 142.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 168.0, 167.0, 168.0, 169.0, 169.0, 171.0, 167.0, 163.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 69.0, 67.0, 68.0, 73.0, 68.0, 66.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1569.9999999999998, "alertThreshold": 2.0}]} 17:23:06 INFO - Return code: 0 17:23:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:23:06 ERROR - # TBPL SUCCESS # 17:23:06 INFO - Running post-action listener: _resource_record_post_action 17:23:06 INFO - Running post-run listener: _resource_record_post_run 17:23:07 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 389120; Write bytes: 301469696; Read time: 296; Write time: 572672 17:23:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14061568; Read time: 0; Write time: 2892 17:23:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 389120; Write bytes: 283549696; Read time: 296; Write time: 560880 17:23:07 INFO - Running post-run listener: _upload_blobber_files 17:23:07 INFO - Blob upload gear active. 17:23:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:23:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:23:08 INFO - (blobuploader) - INFO - Open directory for files ... 17:23:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:23:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:23:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:08 INFO - (blobuploader) - INFO - Done attempting. 17:23:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:23:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:23:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:09 INFO - (blobuploader) - INFO - Done attempting. 17:23:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:23:09 INFO - Return code: 0 17:23:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:23:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:23:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a2ce00e91a8fce762797a596d952508f71132d40d4b4d350d3f8ba683658dc1b3004c6bc297d438ec53469ea0b339b83b5a34f28baa03da1df779f81a18bd33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd83140c837ebee5a5e0610d64f88736109d0f2edf7b6bd95aa452ca18ebf607a47ce4fcd03722b862707d930a0f185e173e79c31f1e21d2d97c4902bd630fb0"} 17:23:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:23:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:23:09 INFO - Contents: 17:23:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a2ce00e91a8fce762797a596d952508f71132d40d4b4d350d3f8ba683658dc1b3004c6bc297d438ec53469ea0b339b83b5a34f28baa03da1df779f81a18bd33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd83140c837ebee5a5e0610d64f88736109d0f2edf7b6bd95aa452ca18ebf607a47ce4fcd03722b862707d930a0f185e173e79c31f1e21d2d97c4902bd630fb0"} 17:23:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:23:09 INFO - Copying logs to upload dir... 17:23:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:23:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.884774 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-14 17:23:09.854276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:23:09.857388) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a2ce00e91a8fce762797a596d952508f71132d40d4b4d350d3f8ba683658dc1b3004c6bc297d438ec53469ea0b339b83b5a34f28baa03da1df779f81a18bd33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd83140c837ebee5a5e0610d64f88736109d0f2edf7b6bd95aa452ca18ebf607a47ce4fcd03722b862707d930a0f185e173e79c31f1e21d2d97c4902bd630fb0"} build_url:https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a2ce00e91a8fce762797a596d952508f71132d40d4b4d350d3f8ba683658dc1b3004c6bc297d438ec53469ea0b339b83b5a34f28baa03da1df779f81a18bd33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd83140c837ebee5a5e0610d64f88736109d0f2edf7b6bd95aa452ca18ebf607a47ce4fcd03722b862707d930a0f185e173e79c31f1e21d2d97c4902bd630fb0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:23:09.886873) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:23:09.887639) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460678540.550188-1820174322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:23:09.970372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:23:09.971111) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:23:09.971699) ========= ========= Total master_lag: 0.19 =========