builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1467223272.96 results: success (0) buildid: 20160629092027 builduid: a3b52b2ddcde40418738a117800d63f1 revision: 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:12.963035) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:12.963526) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:12.963811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:12.983612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:12.983996) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 11:01:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-06-29 11:01:13 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125246 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.127395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.127808) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.177414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.180938) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 --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=bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 11:01:13,462 truncating revision to first 12 chars 2016-06-29 11:01:13,462 Setting DEBUG logging. 2016-06-29 11:01:13,462 attempt 1/10 2016-06-29 11:01:13,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/053b0f43de1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 11:01:13,788 unpacking tar archive at: larch-053b0f43de1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649132 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.846938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.847298) ========= script_repo_revision: 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.847728) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.848000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:01:13.859689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-29 11:01:13.860106) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:01:14 INFO - MultiFileLogger online at 20160629 11:01:14 in /builds/slave/test 11:01:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 11:01:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:01:14 INFO - {'append_to_log': False, 11:01:14 INFO - 'base_work_dir': '/builds/slave/test', 11:01:14 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 11:01:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:01:14 INFO - 'branch': 'Larch-Non-PGO', 11:01:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:14 INFO - 'config_files': ('talos/linux_config.py',), 11:01:14 INFO - 'default_actions': ('clobber', 11:01:14 INFO - 'read-buildbot-config', 11:01:14 INFO - 'download-and-extract', 11:01:14 INFO - 'populate-webroot', 11:01:14 INFO - 'create-virtualenv', 11:01:14 INFO - 'install', 11:01:14 INFO - 'run-tests'), 11:01:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:14 INFO - 'download_minidump_stackwalk': True, 11:01:14 INFO - 'download_symbols': 'ondemand', 11:01:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:14 INFO - 'installer_path': 'installer.exe', 11:01:14 INFO - 'log_level': 'info', 11:01:14 INFO - 'log_name': 'talos', 11:01:14 INFO - 'log_to_console': True, 11:01:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:01:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:01:14 INFO - 'opt_config_files': (), 11:01:14 INFO - 'pip_index': False, 11:01:14 INFO - 'sps_profile': False, 11:01:14 INFO - 'sps_profile_interval': 0, 11:01:14 INFO - 'suite': 'dromaeojs-e10s', 11:01:14 INFO - 'system_bits': '32', 11:01:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:14 INFO - 'title': 'talos-linux64-ix-055', 11:01:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:14 INFO - 'use_talos_json': True, 11:01:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:01:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:14 INFO - 'work_dir': 'build'} 11:01:14 INFO - ##### 11:01:14 INFO - ##### Running clobber step. 11:01:14 INFO - ##### 11:01:14 INFO - Running pre-action listener: _resource_record_pre_action 11:01:14 INFO - Running main action method: clobber 11:01:14 INFO - rmtree: /builds/slave/test/build 11:01:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:01:14 INFO - Running post-action listener: _resource_record_post_action 11:01:14 INFO - ##### 11:01:14 INFO - ##### Running read-buildbot-config step. 11:01:14 INFO - ##### 11:01:14 INFO - Running pre-action listener: _resource_record_pre_action 11:01:14 INFO - Running main action method: read_buildbot_config 11:01:14 INFO - Using buildbot properties: 11:01:14 INFO - { 11:01:14 INFO - "project": "", 11:01:14 INFO - "product": "firefox", 11:01:14 INFO - "script_repo_revision": "production", 11:01:14 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 11:01:14 INFO - "repository": "", 11:01:14 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 11:01:14 INFO - "buildid": "20160629092027", 11:01:14 INFO - "pgo_build": "False", 11:01:14 INFO - "basedir": "/builds/slave/test", 11:01:14 INFO - "buildnumber": 10, 11:01:14 INFO - "slavename": "talos-linux64-ix-055", 11:01:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:01:14 INFO - "platform": "ubuntu64_hw", 11:01:14 INFO - "scheduler": "tests-larch-linux64-talos", 11:01:14 INFO - "branch": "larch", 11:01:14 INFO - "repo_path": "projects/larch", 11:01:14 INFO - "revision": "053b0f43de1f6c52af2ab2187e4d0a11f453a7d4", 11:01:14 INFO - "stage_platform": "linux64", 11:01:14 INFO - "builduid": "a3b52b2ddcde40418738a117800d63f1", 11:01:14 INFO - "slavebuilddir": "test" 11:01:14 INFO - } 11:01:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2. 11:01:14 INFO - Running post-action listener: _resource_record_post_action 11:01:14 INFO - ##### 11:01:14 INFO - ##### Running download-and-extract step. 11:01:14 INFO - ##### 11:01:14 INFO - Running pre-action listener: _resource_record_pre_action 11:01:14 INFO - Running main action method: download_and_extract 11:01:14 INFO - mkdir: /builds/slave/test/build/tests 11:01:14 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')]} 11:01:14 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:01:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 11:01:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 11:01:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 11:01:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:01:15 INFO - Downloaded 1448 bytes. 11:01:15 INFO - Reading from file /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 11:01:15 INFO - Using the following test package requirements: 11:01:15 INFO - {u'common': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 11:01:15 INFO - u'cppunittest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:01:15 INFO - u'firefox-47.0.2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:01:15 INFO - u'gtest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:01:15 INFO - u'firefox-47.0.2.en-US.linux-x86_64.gtest.tests.zip'], 11:01:15 INFO - u'jittest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:01:15 INFO - u'jsshell-linux-x86_64.zip'], 11:01:15 INFO - u'mochitest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:01:15 INFO - u'firefox-47.0.2.en-US.linux-x86_64.mochitest.tests.zip'], 11:01:15 INFO - u'mozbase': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 11:01:15 INFO - u'reftest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:01:15 INFO - u'firefox-47.0.2.en-US.linux-x86_64.reftest.tests.zip'], 11:01:15 INFO - u'talos': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:01:15 INFO - u'firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'], 11:01:15 INFO - u'web-platform': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:01:15 INFO - u'firefox-47.0.2.en-US.linux-x86_64.web-platform.tests.zip'], 11:01:15 INFO - u'webapprt': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 11:01:15 INFO - u'xpcshell': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:01:15 INFO - u'firefox-47.0.2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:01:15 INFO - Downloading packages: [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:01:15 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')]} 11:01:15 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:01:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:01:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:01:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:01:17 INFO - Downloaded 22140718 bytes. 11:01:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:01:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:01:18 INFO - Return code: 0 11:01:18 INFO - Downloading packages: [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:01:18 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')]} 11:01:18 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:01:21 INFO - Downloaded 22140718 bytes. 11:01:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:01:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:01:22 INFO - Return code: 0 11:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:22 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 11:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 11:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 11:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:01:23 INFO - Downloaded 10845194 bytes. 11:01:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:01:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:01:23 INFO - Return code: 0 11:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:23 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:01:29 INFO - Downloaded 59008279 bytes. 11:01:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:01:29 INFO - mkdir: /builds/slave/test/properties 11:01:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:01:29 INFO - Writing to file /builds/slave/test/properties/build_url 11:01:29 INFO - Contents: 11:01:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:01:30 INFO - Running post-action listener: _resource_record_post_action 11:01:30 INFO - Running post-action listener: set_extra_try_arguments 11:01:30 INFO - ##### 11:01:30 INFO - ##### Running populate-webroot step. 11:01:30 INFO - ##### 11:01:30 INFO - Running pre-action listener: _resource_record_pre_action 11:01:30 INFO - Running main action method: populate_webroot 11:01:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:30 INFO - '--tppagecycles', 11:01:30 INFO - '7'], 11:01:30 INFO - 'tests': ['tsvgm']}}, 11:01:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:01:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:01:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:01:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:30 INFO - 'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:30 INFO - 'tests': ['damp', 'tps']}, 11:01:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:30 INFO - 'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['damp', 'tps']}, 11:01:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:01:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:30 INFO - 'other': {'tests': ['a11yr', 11:01:30 INFO - 'ts_paint', 11:01:30 INFO - 'tpaint', 11:01:30 INFO - 'sessionrestore', 11:01:30 INFO - 'sessionrestore_no_auto_restore', 11:01:30 INFO - 'tabpaint']}, 11:01:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['a11yr', 11:01:30 INFO - 'ts_paint', 11:01:30 INFO - 'tpaint', 11:01:30 INFO - 'sessionrestore', 11:01:30 INFO - 'sessionrestore_no_auto_restore', 11:01:30 INFO - 'tabpaint']}, 11:01:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['a11yr', 11:01:30 INFO - 'ts_paint', 11:01:30 INFO - 'tpaint', 11:01:30 INFO - 'sessionrestore', 11:01:30 INFO - 'sessionrestore_no_auto_restore', 11:01:30 INFO - 'tabpaint']}, 11:01:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['a11yr', 11:01:30 INFO - 'ts_paint', 11:01:30 INFO - 'tpaint', 11:01:30 INFO - 'sessionrestore', 11:01:30 INFO - 'sessionrestore_no_auto_restore', 11:01:30 INFO - 'tabpaint']}, 11:01:30 INFO - 'other_l64': {'tests': ['a11yr', 11:01:30 INFO - 'ts_paint', 11:01:30 INFO - 'tpaint', 11:01:30 INFO - 'sessionrestore', 11:01:30 INFO - 'sessionrestore_no_auto_restore', 11:01:30 INFO - 'tabpaint']}, 11:01:30 INFO - 'other_nol64': {'tests': ['a11yr', 11:01:30 INFO - 'ts_paint', 11:01:30 INFO - 'tpaint', 11:01:30 INFO - 'sessionrestore', 11:01:30 INFO - 'sessionrestore_no_auto_restore', 11:01:30 INFO - 'tabpaint']}, 11:01:30 INFO - 'svgr': {'tests': ['tsvgx', 11:01:30 INFO - 'tsvgr_opacity', 11:01:30 INFO - 'tart', 11:01:30 INFO - 'tscrollx', 11:01:30 INFO - 'cart']}, 11:01:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['tsvgx', 11:01:30 INFO - 'tsvgr_opacity', 11:01:30 INFO - 'tart', 11:01:30 INFO - 'tscrollx', 11:01:30 INFO - 'cart']}, 11:01:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:30 INFO - 'tests': ['tp5o']}, 11:01:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:30 INFO - 'talos_options': ['--e10s'], 11:01:30 INFO - 'tests': ['tp5o']}, 11:01:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:30 INFO - 'talos_options': ['--xperf_path', 11:01:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:30 INFO - 'tests': ['tp5n']}, 11:01:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:30 INFO - 'talos_options': ['--e10s', 11:01:30 INFO - '--xperf_path', 11:01:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:30 INFO - 'tests': ['tp5n']}}, 11:01:30 INFO - 'talos.zip': {'path': '', 11:01:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:30 INFO - Running post-action listener: _resource_record_post_action 11:01:30 INFO - ##### 11:01:30 INFO - ##### Running create-virtualenv step. 11:01:30 INFO - ##### 11:01:30 INFO - Running pre-action listener: _resource_record_pre_action 11:01:30 INFO - Running main action method: create_virtualenv 11:01:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:01:30 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 11:01:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:01:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:30 INFO - Using real prefix '/usr' 11:01:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:01:31 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:33 INFO - Installing pip.................done. 11:01:33 INFO - Return code: 0 11:01:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:01:33 INFO - Using env: {'DISPLAY': ':0', 11:01:33 INFO - 'HOME': '/home/cltbld', 11:01:33 INFO - 'LANG': 'en_US.UTF-8', 11:01:33 INFO - 'LANGUAGE': 'en_US:en', 11:01:33 INFO - 'LOGNAME': 'cltbld', 11:01:33 INFO - 'MAIL': '/var/mail/cltbld', 11:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:33 INFO - 'MOZ_NO_REMOTE': '1', 11:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:33 INFO - 'NO_EM_RESTART': '1', 11:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:33 INFO - 'PWD': '/builds/slave/test', 11:01:33 INFO - 'SHELL': '/bin/bash', 11:01:33 INFO - 'SHLVL': '1', 11:01:33 INFO - 'TERM': 'linux', 11:01:33 INFO - 'TMOUT': '86400', 11:01:33 INFO - 'USER': 'cltbld', 11:01:33 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:33 INFO - '_': '/tools/buildbot/bin/python'} 11:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:33 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 11:01:33 INFO - Cleaning up... 11:01:33 INFO - Return code: 0 11:01:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:01:33 INFO - Using env: {'DISPLAY': ':0', 11:01:33 INFO - 'HOME': '/home/cltbld', 11:01:33 INFO - 'LANG': 'en_US.UTF-8', 11:01:33 INFO - 'LANGUAGE': 'en_US:en', 11:01:33 INFO - 'LOGNAME': 'cltbld', 11:01:33 INFO - 'MAIL': '/var/mail/cltbld', 11:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:33 INFO - 'MOZ_NO_REMOTE': '1', 11:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:33 INFO - 'NO_EM_RESTART': '1', 11:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:33 INFO - 'PWD': '/builds/slave/test', 11:01:33 INFO - 'SHELL': '/bin/bash', 11:01:33 INFO - 'SHLVL': '1', 11:01:33 INFO - 'TERM': 'linux', 11:01:33 INFO - 'TMOUT': '86400', 11:01:33 INFO - 'USER': 'cltbld', 11:01:33 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:33 INFO - '_': '/tools/buildbot/bin/python'} 11:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:33 INFO - Downloading/unpacking psutil>=0.7.1 11:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:35 INFO - Installing collected packages: psutil 11:01:35 INFO - Running setup.py install for psutil 11:01:35 INFO - building 'psutil._psutil_linux' extension 11:01:35 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 11:01:35 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 11:01:35 INFO - building 'psutil._psutil_posix' extension 11:01:35 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 11:01:36 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 11:01:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:36 INFO - Successfully installed psutil 11:01:36 INFO - Cleaning up... 11:01:36 INFO - Return code: 0 11:01:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:01:36 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')]} 11:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:36 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')]} 11:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:36 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 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01:36 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 11:01:36 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 11:01:36 INFO - Using env: {'DISPLAY': ':0', 11:01:36 INFO - 'HOME': '/home/cltbld', 11:01:36 INFO - 'LANG': 'en_US.UTF-8', 11:01:36 INFO - 'LANGUAGE': 'en_US:en', 11:01:36 INFO - 'LOGNAME': 'cltbld', 11:01:36 INFO - 'MAIL': '/var/mail/cltbld', 11:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:36 INFO - 'MOZ_NO_REMOTE': '1', 11:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:36 INFO - 'NO_EM_RESTART': '1', 11:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:36 INFO - 'PWD': '/builds/slave/test', 11:01:36 INFO - 'SHELL': '/bin/bash', 11:01:36 INFO - 'SHLVL': '1', 11:01:36 INFO - 'TERM': 'linux', 11:01:36 INFO - 'TMOUT': '86400', 11:01:36 INFO - 'USER': 'cltbld', 11:01:36 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:36 INFO - '_': '/tools/buildbot/bin/python'} 11:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:01:38 INFO - Installing collected packages: mozsystemmonitor 11:01:38 INFO - Running setup.py install for mozsystemmonitor 11:01:38 INFO - Successfully installed mozsystemmonitor 11:01:38 INFO - Cleaning up... 11:01:38 INFO - Return code: 0 11:01:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:38 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 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01:38 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 11:01:38 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 11:01:38 INFO - Using env: {'DISPLAY': ':0', 11:01:38 INFO - 'HOME': '/home/cltbld', 11:01:38 INFO - 'LANG': 'en_US.UTF-8', 11:01:38 INFO - 'LANGUAGE': 'en_US:en', 11:01:38 INFO - 'LOGNAME': 'cltbld', 11:01:38 INFO - 'MAIL': '/var/mail/cltbld', 11:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:38 INFO - 'MOZ_NO_REMOTE': '1', 11:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:38 INFO - 'NO_EM_RESTART': '1', 11:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:38 INFO - 'PWD': '/builds/slave/test', 11:01:38 INFO - 'SHELL': '/bin/bash', 11:01:38 INFO - 'SHLVL': '1', 11:01:38 INFO - 'TERM': 'linux', 11:01:38 INFO - 'TMOUT': '86400', 11:01:38 INFO - 'USER': 'cltbld', 11:01:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:38 INFO - '_': '/tools/buildbot/bin/python'} 11:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:01:40 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 11:01:40 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 11:01:40 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 11:01:40 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 11:01:40 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 11:01:40 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 11:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:01:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01:41 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 11:01:41 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 11:01:41 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 11:01:41 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 11:01:41 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 11:01:41 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 11:01:41 INFO - Downloading docopt-0.6.1.tar.gz 11:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:41 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:41 INFO - Running setup.py install for blobuploader 11:01:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:01:41 INFO - Running setup.py install for requests 11:01:41 INFO - Running setup.py install for docopt 11:01:41 INFO - Successfully installed blobuploader requests docopt 11:01:41 INFO - Cleaning up... 11:01:41 INFO - Return code: 0 11:01:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:41 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 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01:41 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 11:01:41 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 11:01:41 INFO - Using env: {'DISPLAY': ':0', 11:01:41 INFO - 'HOME': '/home/cltbld', 11:01:41 INFO - 'LANG': 'en_US.UTF-8', 11:01:41 INFO - 'LANGUAGE': 'en_US:en', 11:01:41 INFO - 'LOGNAME': 'cltbld', 11:01:41 INFO - 'MAIL': '/var/mail/cltbld', 11:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:41 INFO - 'MOZ_NO_REMOTE': '1', 11:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:41 INFO - 'NO_EM_RESTART': '1', 11:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:41 INFO - 'PWD': '/builds/slave/test', 11:01:41 INFO - 'SHELL': '/bin/bash', 11:01:41 INFO - 'SHLVL': '1', 11:01:41 INFO - 'TERM': 'linux', 11:01:41 INFO - 'TMOUT': '86400', 11:01:41 INFO - 'USER': 'cltbld', 11:01:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:41 INFO - '_': '/tools/buildbot/bin/python'} 11:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:01:42 INFO - Running setup.py (path:/tmp/pip-Pba8HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:01:42 INFO - Running setup.py (path:/tmp/pip-zA8fSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:01:42 INFO - Running setup.py (path:/tmp/pip-Q8bKkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:01:42 INFO - Running setup.py (path:/tmp/pip-gxAtYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:01:42 INFO - Running setup.py (path:/tmp/pip-rt1lNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:01:42 INFO - Running setup.py (path:/tmp/pip-BjwNOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:01:42 INFO - Running setup.py (path:/tmp/pip-ym4OsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:01:42 INFO - Running setup.py (path:/tmp/pip-fG8ENn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:01:42 INFO - Running setup.py (path:/tmp/pip-UVs1rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:01:42 INFO - Running setup.py (path:/tmp/pip-Wrpw5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:01:42 INFO - Running setup.py (path:/tmp/pip-GT_dFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:01:42 INFO - Running setup.py (path:/tmp/pip-g67a2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:01:43 INFO - Running setup.py (path:/tmp/pip-DwbkJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:01:43 INFO - Running setup.py (path:/tmp/pip-25ngBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:43 INFO - Running setup.py (path:/tmp/pip-aTxDB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:01:43 INFO - Running setup.py (path:/tmp/pip-41rCM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:01:43 INFO - Running setup.py (path:/tmp/pip-7E3PZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:01:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:01:43 INFO - Running setup.py install for manifestparser 11:01:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:01:43 INFO - Running setup.py install for mozcrash 11:01:43 INFO - Running setup.py install for mozdebug 11:01:43 INFO - Running setup.py install for mozdevice 11:01:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:01:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:01:43 INFO - Running setup.py install for mozfile 11:01:43 INFO - Running setup.py install for mozhttpd 11:01:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:01:43 INFO - Running setup.py install for mozinfo 11:01:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Running setup.py install for mozInstall 11:01:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Running setup.py install for mozleak 11:01:44 INFO - Running setup.py install for mozlog 11:01:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Running setup.py install for moznetwork 11:01:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Running setup.py install for mozprocess 11:01:44 INFO - Running setup.py install for mozprofile 11:01:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Running setup.py install for mozrunner 11:01:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:01:44 INFO - Running setup.py install for mozscreenshot 11:01:44 INFO - Running setup.py install for moztest 11:01:45 INFO - Running setup.py install for mozversion 11:01:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:01:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:01:45 INFO - Cleaning up... 11:01:45 INFO - Return code: 0 11:01:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:45 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 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01:45 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 11:01:45 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 11:01:45 INFO - Using env: {'DISPLAY': ':0', 11:01:45 INFO - 'HOME': '/home/cltbld', 11:01:45 INFO - 'LANG': 'en_US.UTF-8', 11:01:45 INFO - 'LANGUAGE': 'en_US:en', 11:01:45 INFO - 'LOGNAME': 'cltbld', 11:01:45 INFO - 'MAIL': '/var/mail/cltbld', 11:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:45 INFO - 'MOZ_NO_REMOTE': '1', 11:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:45 INFO - 'NO_EM_RESTART': '1', 11:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:45 INFO - 'PWD': '/builds/slave/test', 11:01:45 INFO - 'SHELL': '/bin/bash', 11:01:45 INFO - 'SHLVL': '1', 11:01:45 INFO - 'TERM': 'linux', 11:01:45 INFO - 'TMOUT': '86400', 11:01:45 INFO - 'USER': 'cltbld', 11:01:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:45 INFO - '_': '/tools/buildbot/bin/python'} 11:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:01:45 INFO - Running setup.py (path:/tmp/pip-dhTJmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:01:45 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)) 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:01:45 INFO - Running setup.py (path:/tmp/pip-t9dre4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:01:45 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)) 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:01:45 INFO - Running setup.py (path:/tmp/pip-xaiWZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:01:45 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)) 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:01:45 INFO - Running setup.py (path:/tmp/pip-LgNmD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:01:45 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)) 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:01:45 INFO - Running setup.py (path:/tmp/pip-0XxM19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:01:45 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)) 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:01:45 INFO - Running setup.py (path:/tmp/pip-05jABS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:01:45 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)) 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:01:45 INFO - Running setup.py (path:/tmp/pip-lYpwKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:01:45 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)) 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:01:45 INFO - Running setup.py (path:/tmp/pip-R3n6aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:01:45 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)) 11:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:01:45 INFO - Running setup.py (path:/tmp/pip-PtP3LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:01:46 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)) 11:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:01:46 INFO - Running setup.py (path:/tmp/pip-ooTEFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:01:46 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)) 11:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:01:46 INFO - Running setup.py (path:/tmp/pip-nuW4C4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:01:46 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)) 11:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:01:46 INFO - Running setup.py (path:/tmp/pip-kUGrj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:01:46 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)) 11:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:01:46 INFO - Running setup.py (path:/tmp/pip-1bO5RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:01:46 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)) 11:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:01:46 INFO - Running setup.py (path:/tmp/pip-YBifFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:01:46 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)) 11:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:46 INFO - Running setup.py (path:/tmp/pip-5PlXwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:01:46 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)) 11:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:01:46 INFO - Running setup.py (path:/tmp/pip-Aj1g6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:01:46 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)) 11:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:01:46 INFO - Running setup.py (path:/tmp/pip-Ov4r9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:01:46 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)) 11:01:46 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)) 11:01:46 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)) 11:01:46 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)) 11:01:46 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)) 11:01:46 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)) 11:01:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:48 INFO - Downloading blessings-1.6.tar.gz 11:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:01:48 INFO - Installing collected packages: blessings 11:01:48 INFO - Running setup.py install for blessings 11:01:48 INFO - Successfully installed blessings 11:01:48 INFO - Cleaning up... 11:01:48 INFO - Return code: 0 11:01:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:01:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:48 INFO - Reading from file tmpfile_stdout 11:01:48 INFO - Current package versions: 11:01:48 INFO - argparse == 1.2.1 11:01:48 INFO - blessings == 1.6 11:01:48 INFO - blobuploader == 1.2.4 11:01:48 INFO - docopt == 0.6.1 11:01:48 INFO - manifestparser == 1.1 11:01:48 INFO - mozInstall == 1.12 11:01:48 INFO - mozcrash == 0.17 11:01:48 INFO - mozdebug == 0.1 11:01:48 INFO - mozdevice == 0.48 11:01:48 INFO - mozfile == 1.2 11:01:48 INFO - mozhttpd == 0.7 11:01:48 INFO - mozinfo == 0.9 11:01:48 INFO - mozleak == 0.1 11:01:48 INFO - mozlog == 3.1 11:01:48 INFO - moznetwork == 0.27 11:01:48 INFO - mozprocess == 0.22 11:01:48 INFO - mozprofile == 0.28 11:01:48 INFO - mozrunner == 6.11 11:01:48 INFO - mozscreenshot == 0.1 11:01:48 INFO - mozsystemmonitor == 0.0 11:01:48 INFO - moztest == 0.7 11:01:48 INFO - mozversion == 1.4 11:01:48 INFO - psutil == 3.1.1 11:01:48 INFO - requests == 1.2.3 11:01:48 INFO - wsgiref == 0.1.2 11:01:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:01:48 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')]} 11:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:48 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')]} 11:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:48 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 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01:48 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 11:01:48 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 11:01:48 INFO - Using env: {'DISPLAY': ':0', 11:01:48 INFO - 'HOME': '/home/cltbld', 11:01:48 INFO - 'LANG': 'en_US.UTF-8', 11:01:48 INFO - 'LANGUAGE': 'en_US:en', 11:01:48 INFO - 'LOGNAME': 'cltbld', 11:01:48 INFO - 'MAIL': '/var/mail/cltbld', 11:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:48 INFO - 'MOZ_NO_REMOTE': '1', 11:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:48 INFO - 'NO_EM_RESTART': '1', 11:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:48 INFO - 'PWD': '/builds/slave/test', 11:01:48 INFO - 'SHELL': '/bin/bash', 11:01:48 INFO - 'SHLVL': '1', 11:01:48 INFO - 'TERM': 'linux', 11:01:48 INFO - 'TMOUT': '86400', 11:01:48 INFO - 'USER': 'cltbld', 11:01:48 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:48 INFO - '_': '/tools/buildbot/bin/python'} 11:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 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)) 11:01:49 INFO - Cleaning up... 11:01:49 INFO - Return code: 0 11:01:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:01: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')]} 11:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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')]} 11:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01: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', 'jsonschema'] in /builds/slave/test/build 11:01: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 jsonschema 11:01:49 INFO - Using env: {'DISPLAY': ':0', 11:01:49 INFO - 'HOME': '/home/cltbld', 11:01:49 INFO - 'LANG': 'en_US.UTF-8', 11:01:49 INFO - 'LANGUAGE': 'en_US:en', 11:01:49 INFO - 'LOGNAME': 'cltbld', 11:01:49 INFO - 'MAIL': '/var/mail/cltbld', 11:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:49 INFO - 'MOZ_NO_REMOTE': '1', 11:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:49 INFO - 'NO_EM_RESTART': '1', 11:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:49 INFO - 'PWD': '/builds/slave/test', 11:01:49 INFO - 'SHELL': '/bin/bash', 11:01:49 INFO - 'SHLVL': '1', 11:01:49 INFO - 'TERM': 'linux', 11:01:49 INFO - 'TMOUT': '86400', 11:01:49 INFO - 'USER': 'cltbld', 11:01:49 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:49 INFO - '_': '/tools/buildbot/bin/python'} 11:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:49 INFO - Downloading/unpacking jsonschema 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01: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 11:01:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:01:51 INFO - Downloading/unpacking functools32 (from jsonschema) 11:01:51 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 11:01:51 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 11:01:51 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 11:01:51 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 11:01:51 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 11:01:51 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 11:01:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:01:51 INFO - warning: no files found matching '*.txt' 11:01:51 INFO - no previously-included directories found matching 'build' 11:01:51 INFO - no previously-included directories found matching 'dist' 11:01:51 INFO - no previously-included directories found matching '.git*' 11:01:51 INFO - Installing collected packages: jsonschema, functools32 11:01:51 INFO - Running setup.py install for functools32 11:01:51 INFO - warning: no files found matching '*.txt' 11:01:51 INFO - no previously-included directories found matching 'build' 11:01:51 INFO - no previously-included directories found matching 'dist' 11:01:51 INFO - no previously-included directories found matching '.git*' 11:01:51 INFO - Successfully installed jsonschema functools32 11:01:51 INFO - Cleaning up... 11:01:51 INFO - Return code: 0 11:01:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41f37df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', '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 11:01:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:01:51 INFO - Using env: {'DISPLAY': ':0', 11:01:51 INFO - 'HOME': '/home/cltbld', 11:01:51 INFO - 'LANG': 'en_US.UTF-8', 11:01:51 INFO - 'LANGUAGE': 'en_US:en', 11:01:51 INFO - 'LOGNAME': 'cltbld', 11:01:51 INFO - 'MAIL': '/var/mail/cltbld', 11:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:51 INFO - 'MOZ_NO_REMOTE': '1', 11:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:51 INFO - 'NO_EM_RESTART': '1', 11:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:51 INFO - 'PWD': '/builds/slave/test', 11:01:51 INFO - 'SHELL': '/bin/bash', 11:01:51 INFO - 'SHLVL': '1', 11:01:51 INFO - 'TERM': 'linux', 11:01:51 INFO - 'TMOUT': '86400', 11:01:51 INFO - 'USER': 'cltbld', 11:01:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:51 INFO - '_': '/tools/buildbot/bin/python'} 11:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:52 INFO - Downloading/unpacking flake8 11:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:01:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:01:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:01:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:01:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:01:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:01:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:01:54 INFO - no previously-included directories found matching 'docs/_build' 11:01:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:01:54 INFO - Running setup.py install for pep8 11:01:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:01:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:01:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:01:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:01:54 INFO - no previously-included directories found matching 'docs/_build' 11:01:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:01:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:01:54 INFO - Cleaning up... 11:01:55 INFO - Return code: 0 11:01:55 INFO - Running post-action listener: _resource_record_post_action 11:01:55 INFO - Running post-action listener: _start_resource_monitoring 11:01:55 INFO - Starting resource monitoring. 11:01:55 INFO - ##### 11:01:55 INFO - ##### Running install step. 11:01:55 INFO - ##### 11:01:55 INFO - Running pre-action listener: _resource_record_pre_action 11:01:55 INFO - Running main action method: install 11:01:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:01:55 INFO - Reading from file tmpfile_stdout 11:01:55 INFO - Detecting whether we're running mozinstall >=1.0... 11:01:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:01:55 INFO - Reading from file tmpfile_stdout 11:01:55 INFO - Output received: 11:01:55 INFO - Usage: mozinstall [options] installer 11:01:55 INFO - Options: 11:01:55 INFO - -h, --help show this help message and exit 11:01:55 INFO - -d DEST, --destination=DEST 11:01:55 INFO - Directory to install application into. [default: 11:01:55 INFO - "/builds/slave/test"] 11:01:55 INFO - --app=APP Application being installed. [default: firefox] 11:01:55 INFO - mkdir: /builds/slave/test/build/application 11:01:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:02:10 INFO - Reading from file tmpfile_stdout 11:02:10 INFO - Output received: 11:02:10 INFO - /builds/slave/test/build/application/firefox/firefox 11:02:10 INFO - Running post-action listener: _resource_record_post_action 11:02:10 INFO - ##### 11:02:10 INFO - ##### Running run-tests step. 11:02:10 INFO - ##### 11:02:10 INFO - Running pre-action listener: _resource_record_pre_action 11:02:10 INFO - Running main action method: run_tests 11:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:02:10 INFO - Python 2.7.3 11:02:10 INFO - Return code: 0 11:02:10 INFO - grabbing minidump binary from tooltool 11:02:10 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')]} 11:02:10 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 0x1056160>, '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 0x1057060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10574f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:02:10 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 11:02:10 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 11:02:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:10 INFO - Return code: 0 11:02:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:02:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:02:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:02:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:02:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:02:11 INFO - Return code: 0 11:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 11:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 11:02:11 INFO - Using env: {'DISPLAY': ':0', 11:02:11 INFO - 'HOME': '/home/cltbld', 11:02:11 INFO - 'LANG': 'en_US.UTF-8', 11:02:11 INFO - 'LANGUAGE': 'en_US:en', 11:02:11 INFO - 'LOGNAME': 'cltbld', 11:02:11 INFO - 'MAIL': '/var/mail/cltbld', 11:02:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:02:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:11 INFO - 'MOZ_NO_REMOTE': '1', 11:02:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:11 INFO - 'NO_EM_RESTART': '1', 11:02:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:11 INFO - 'PWD': '/builds/slave/test', 11:02:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:02:11 INFO - 'SHELL': '/bin/bash', 11:02:11 INFO - 'SHLVL': '1', 11:02:11 INFO - 'TERM': 'linux', 11:02:11 INFO - 'TMOUT': '86400', 11:02:11 INFO - 'USER': 'cltbld', 11:02:11 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221', 11:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:11 INFO - '_': '/tools/buildbot/bin/python'} 11:02:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 11:02:11 INFO - mozversion application_buildid: 20160629092027 11:02:11 INFO - mozversion application_changeset: 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 11:02:11 INFO - mozversion application_display_name: Nightly 11:02:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:11 INFO - mozversion application_name: Firefox 11:02:11 INFO - mozversion application_remotingname: firefox 11:02:11 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 11:02:11 INFO - mozversion application_vendor: Mozilla 11:02:11 INFO - mozversion application_version: 47.0.2 11:02:11 INFO - mozversion platform_buildid: 20160629092027 11:02:11 INFO - mozversion platform_changeset: 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 11:02:11 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 11:02:11 INFO - mozversion platform_version: 47.0.2 11:02:11 INFO - using testdate: 1467223331 11:02:11 INFO - actual date: 1467223331 11:02:11 INFO - starting webserver on 'localhost:51843' 11:02:11 INFO - SUITE-START | Running 2 tests 11:02:11 INFO - TEST-START | dromaeo_css 11:02:11 INFO - operating with platform_type : linux_ 11:02:11 INFO - Initialising browser for dromaeo_css test... 11:02:11 INFO - TEST-INFO | started process 6495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqkDtGx/profile http://localhost:51843/getInfo.html) 11:02:15 INFO - PROCESS | 6495 | 11:02:15 INFO - PROCESS | 6495 | (process:6575): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:02:16 INFO - PROCESS | 6495 | __metrics Screen width/height:1600/1200 11:02:16 INFO - PROCESS | 6495 | colorDepth:24 11:02:16 INFO - PROCESS | 6495 | Browser inner width/height: 1024/697 11:02:16 INFO - PROCESS | 6495 | __metrics 11:02:16 ERROR - PROCESS | 6495 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 11:02:17 INFO - TEST-INFO | 6495: exit 0 11:02:17 INFO - Browser initialized. 11:02:17 INFO - Running cycle 1/1 for dromaeo_css test... 11:02:17 INFO - TEST-INFO | started process 6625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqkDtGx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:19 INFO - PROCESS | 6625 | 11:02:19 INFO - PROCESS | 6625 | (process:6693): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:02:29 INFO - PROCESS | 6625 | RSS: Main: 148967424 11:02:29 INFO - PROCESS | 6625 | 11:03:18 INFO - PROCESS | 6625 | 1467223398965 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] 11:05:30 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51843/tests/dromaeo/cssquery-ext.html) 11:05:31 INFO - PROCESS | 6625 | RSS: Main: 151826432 11:05:31 INFO - PROCESS | 6625 | 11:08:32 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51843/tests/dromaeo/cssquery-ext.html (next: http://localhost:51843/tests/dromaeo/cssquery-jquery.html) 11:08:33 INFO - PROCESS | 6625 | RSS: Main: 152449024 11:08:33 INFO - PROCESS | 6625 | 11:11:35 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51843/tests/dromaeo/cssquery-mootools.html) 11:11:35 INFO - PROCESS | 6625 | RSS: Main: 150478848 11:11:35 INFO - PROCESS | 6625 | 11:14:37 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51843/tests/dromaeo/cssquery-prototype.html) 11:14:38 INFO - PROCESS | 6625 | RSS: Main: 152203264 11:14:38 INFO - PROCESS | 6625 | 11:17:40 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51843/tests/dromaeo/cssquery-yui.html) 11:17:41 INFO - PROCESS | 6625 | RSS: Main: 150933504 11:17:41 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51843/tests/dromaeo/cssquery-yui.html (next: http://localhost:51843/tests/dromaeo/cssquery-dojo.html) 11:20:43 INFO - PROCESS | 6625 | RSS: Main: 152768512 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | __start_tp_report 11:20:43 INFO - PROCESS | 6625 | _x_x_mozilla_page_load 11:20:43 INFO - PROCESS | 6625 | _x_x_mozilla_page_load_details 11:20:43 INFO - PROCESS | 6625 | |i|pagename|runs| 11:20:43 INFO - PROCESS | 6625 | |0;dojo.html;2795.3989892173186;2846.587244849496;2870.210692059685;2901.970980290198;2914.927126821829;4690.343351930733;4701.976490117553;4704.247320428732;4714.599259062979;4730.692504987173;4681.274402467615;4713;4735.644826637998;4744.90510189796;4761.285807128932;4342.457192850894;4363.236433624119;4403.911921761563;4406.427164468614;4432.445944256968;4251.277282861905;4390.385346051556;4398.934015989763;4406.955930440703;4433.401490798749;4421.513633500313;4425;4491.842785502508;4512.052468981501;4519.819207231707;4401.405810215628;4404.427424434835;4412.426384570017;4414.073044660625;4433.756143412111;3936.980315098435;4327.177836211141;4371.890702732426;4378.036831896978;4396.516383197878;4612.58486736192;4621.69958952667;4626.121037002992;4666.440027196724;4688.343631891538;5003.449620541737;5021.6735912165595;5026.6983980960895;5040.218766091225;5073.289739436482;4945.727984960826;5044.823431179928;5122.667026643257;5122.92315615266;5129.8717532062;4704.811807527695;4712.575868171881;4732.455767586737;4741.099191153669;4754.619630429626;5024.2463630454995;5167.6641018333685;5177.249298851721;5217.165253559412;5245.737713114329;5005.1241032819835;5049.722265275445;5067.239914012854;5070.797168113308;5100.387953445536;5043.293938848564;5045.520675535819;5051.772670229849;5054.620903432184;5088.262201980692;4968.925466118011;4985.950140498621;4987.600991920638;4996.075725990703;5040.672356296829;5026.547610715053;5045.697258164522;5070.898582028339;5081.23781432788;5087.440381558025;4307.9445535843915;4326.978365108154;4328.632066274402;4333.58830911063;4350.825966961286;3709.3694072007283;3766.303233901737;3772.245550889833;3790.9241815164096;3819.388897776398;4320.179165958458;4336.046069864625;4386.495553011381;4417.249067658506;4495.145922274757;4928.7289199093675;4962.950370496321;4990.700557966461;4997.9750101249265;5020.849374518771;4395.956040439554;4408.493023302297;4455.443069616298;4524;4550.567696068868;4526.479454862667;4529.048899731028;4538.72767633943;4539.886502837456;4548.476925153584;4840.298156767249;4856.295837103671;4862.610991120772;4864.73243971585;4868.780904859361;4870.391201099863;5089.847304580869;5149.201873709581;5182.455842136672;5187.662801917863;4839.612830973584;4850.46644869057;4863.294822250683;4871.805127794849;4896.804127834846;4840.975795121143;4983.177775666974;4991.625628077982;4999.800007999639;5025.924611130909;5093.1341671915125;5132.615053871049;5148.536631703165;5163.09645811989;5186.273921651047;4914.213725803854;4970.900581988412;4976.029674213639;4976.452590215001;5003;4737.881552961066;4886.853394398174;4931.580815630568;4988.102141614544;5014.448410674896;4790.305405716222;4793.592544633745;4813.3983252093485;4826.975865120792;4856.490068542894;4881.048195601824;4942.1598328285;4942.8764280893265;4945.23348880924;4974.552290293891;4739.810407583658;4763.2378819390115;4818.397700287464;4846.079244943449;4885.267209918541 11:20:43 INFO - PROCESS | 6625 | |1;ext.html;474.4580114627463;501.388306266355;508.7456271864068;509.60505608153676;518.6628691350621;27023.5946460803;34610.826945865265;34940;34966.47550286748;35013.64986350139;37489.62510374896;37900;37993.62006379935;38129.42805857914;38266.8086659567;8018.0779210390965;8180.181981801802;8191.754247372588;8214.13751556087;8225.876611850827;7833.725819596315;7996.160403157672;8000.439969202158;8030.076541197749;8032.1164671886045;7976.082750483711;8031.915691381676;8050.355971522294;8060.798480037987;8061.4760040597175;7939.722109726161;8004.439689221756;8011.158828323029;8232.17678232178;8257.876131858027;8123.634436450374;8221.79445513867;8247.711330103477;8270.710525131652;8293.792655183608;39404.40893386601;39473.40789888154;39766.40350394746;39827.20345593101;39834.60165398367;2678;2725.6047873058296;2810.1007677543193;2836.517791975369;3112.579801726783;29567.40865182684;29717.405651886842;29878.85060574705;30078;30382.240443988856;3176.2059485128716;3215;3227.4674678678225;3257.9022629321157;3297.670232976707;223840;224518;224656;225706;226519;41033.38449923253;41505;58881;59381.10928336078;59406;43028;43491.13017739628;43493.56506434958;43530.347044794355;43610.12779744387;13059.281739504419;13141.605751827461;13217.933910330386;13244.73510529784;13253.204807711569;9510.33427660071;9555.808883822285;9564.378315409476;9570.377925434825;9585.376950498196;14586.41654333836;14660.340284687214;14702.55892323232;14769.261536923112;14806.333714982851;5568.109102543654;5678.835838653066;5699.686517241508;5720.570957178228;5796.333421656564;910.4264313482464;936.9109934556343;955.507913424587;956.8803899512561;990.6334656177261;27662.3084422887;27699.446011079664;27951.301217469318;27981.86009069982;28406.431871362456;969.5879251318162;971.5093877591771;971.9076687714655;1015.7968406318765;1030.5877648940484;14432.639184020274;14872.851271487363;14898.478553250585;15098;15100;278173;281238;281859;282153;283195;50808.49191508112;50973;51067.489325106275;51118.74440627773;51262;1270.5489551209373;1313.5599574142768;1327.634900402397;1336.9598912032654;1340.2092765268537;26869;27702.307442314104;27986.300342491602;28054.71945280521;28356.574651379833;43778.343324850786;44155.77922110369;44346;44469.33296000627;44550;267031;267320;267688;268974;270173;32281;32634;32941.835290823394;42657.78671106625;43230;38186.618133819415;38236.23527529378;38566.80716596399;38825;39332;36418.45372319364;36588.81705591455;36607.81696091503;36694.266114677026;37087;34461.65538344585;36486;36532.269354613294;36724.44913326249;36821.81589092038;34189;36272;37560.24879502449;39744.602553975245;41329.380059299736;31834.6816531841;32505;32675.509867351535;32744.50883236801;33031.50452743163;25762;25828.483430331664;25858.87070564635;25990.121150080937;26165.73834261633 11:20:43 INFO - PROCESS | 6625 | |2;jquery.html;352.35519000229584;359.9982000089999;361.6365552619617;363.5746176972941;364.72281066389536;15546.689066218683;15684.529464116065;17357.479275621736;17447.389341373055;17464.563385915357;14580.052296600714;14698.485553005621;14812.6296842579;14849.925750371232;14875.702485950302;4929.950700493003;4983.103041452537;5164.535191832734;5180.6891586504935;5184.922226166611;5019.8705291309525;5125.333706618135;5129.461406552315;5150.407703114152;5158.3552055993005;4955.231939049453;5101.744912754366;5101.948980510185;5129.4357620661885;5138.177891537355;5023.045621331954;5094.2103973884105;5105.872353191163;5134.332536770196;5135.691858488484;4565.771711414416;4567.6574256930535;4570.337301091323;4577.267637178069;4578.084383123389;19399.127039283125;19611.411657650293;19863.708858924125;20050.398488045237;20109.39671809848;1869.5419622192514;1899.705545640428;1960.4216756056996;2164.3615133535645;2335.719713634358;12744.171628844095;12945.223286602833;13086.476540938445;13357.332133393389;13397.933010334984;1709.794824621041;1772.787265528132;1805.6840052990806;1822.662807380639;1843.3456123076248;54849.45150548483;55984.72007639936;56113.43886561123;56428;56775.432245677424;9012.324075694349;9035.00614932357;9080.909190908138;9165.862512062324;9324.440533568008;12052.758944821055;12059.155859089955;12061.75876482483;12067.577634782916;12082.939585302018;6733.764318248838;6752.729890804411;6794.3545363190415;6797.286284940109;6804.489663275274;6435.517336199804;6452.387023232785;6489.415952564292;6493.415592596689;6505.739770409131;5507.366652834895;5580.190872323572;5651.689157096399;5653.265075540154;5657.57568182388;1665.3421898350084;1682.7644129821836;1683.6380178261732;1753.4476639858403;1758.2263803926232;872.4983134697575;896.2740180453853;990.2375171118342;991.5290237137447;1002.1481740520645;13701.725965480635;15960.920195398949;16290.941088829188;16937.661246774995;17056.914715426345;912.6486302773347;945.7919257763418;948.3503799897093;957.875476188105;968.8449848024283;9631.951840240894;9649.228061755182;9664;9949.204063674888;9972.9528399517;377085;377984;379086;381258;391321;38666.80666596649;42530.78734606369;52187.21719174215;58362;59752.70123649441;901.3510272603846;901.9413738107002;913.9497327647043;923.7228831350702;937.2501998401252;13974.441022358991;14683.853161468249;14857.108573485626;15039.699206015599;15446.691066178839;29450.263743406587;29866.253343666584;30443.086707398812;30526.542101868934;30634.693653063183;33658.49512257367;35225;35368.11579710528;35703.28593428169;35864.82067589645;7464.701411943462;7559;7661.846763064596;7791.415643826849;7843.921560784547;10864.185186110915;11934.701632459259;11936.76126477483;12030.939845300718;12138.211016283913;10134.6452874152;10466.058054775107;10522.473876306307;10648.148148148284;10960.068394186583;10402.687919362432;10538.525766340379;10601.734956626146;10621.309614875008;10673.679789606324;10560;10602.46987650599;10608.151347892304;10627;10752.08607268391;7317.597532135784;7492.812679683051;7864;7899.131095579596;7939.28546430824;9832.60669573209;10102.646407376;10141.543630536496;10175.389476631426;10425.478726063515 11:20:43 INFO - PROCESS | 6625 | |3;mootools.html;1432.756431406661;1461.1087236785559;1639.959001024975;1755.4207111653157;1834.5780470491786;7660.119086305062;7718.343940765035;7817.413693972946;7954.40341974352;7958.3633309335255;7503.812404689886;7564.470487065908;7588.127365352986;7601.581912994797;7633.351165150955;2129.7124888140097;2152.2467136502178;2156.9892150539304;2159.265849611132;2170.251263314154;2236.3291012696127;2259.175400978639;2259.6836442898007;2261.5589959957815;2261.739899911515;2195.19875245535;2205.5368372641765;2212.4579478027827;2215.656573231152;2225.020990764067;2185.530111026129;2196.8572042817245;2200.3179014505554;2200.5696297406653;2201.9779802202092;2182.5962196993605;2202.680611311367;2223.288547664748;2224.8887555622314;2224.922127725522;7636.3890888728765;7661;7680.462367634268;7686.1929497402525;7722.575258360788;4252.936205956913;4354.238008348558;4391.758453285068;4399.164158809848;4401.053773438726;2938.6646156612187;3031.181580973147;3081.9229519261976;3087.9073627791204;3092.5515800208846;950.8763860698065;982.2191357870439;982.9950850245774;999.7650552120245;1003.7390278527563;10573.20700947432;10665.093467055309;10694.786104277871;10700.143988480902;10717.46412679363;4030.3148464760475;4047.838086476508;4136.131412403369;4154.189932963043;4185.372194170899;8605.483670979762;8624.310055195569;8632.525211113323;8635.654573816977;8645.049044605088;4528.139653465831;4537.2059889519205;4542.273236282179;4545.704529205591;4551.112533056023;3467.3065386922717;3995.081131339808;4041.9797901010893;4075.3886916962692;4088.713790034669;3377.8142202178624;3433.261848702491;3435.278591495764;3437.2438063625964;3473.044912648991;994.7165057958592;997.680742162501;1006.285537268533;1031.0874875734878;1033.5917312661607;1089.7765957978754;1169.7192673758236;1176.3588844079825;1182.456070207714;1232.186756740547;7253.709851605982;7263.963680181671;7273.490855640161;7286.162091359562;7318.560886346836;463.3304874456378;479.35526716566164;483.835495931385;488.3529323646183;488.3529323646183;5461;5677.914831277534;5694.715264236772;5710.486056254957;5734.340550836707;9546.522673866279;9864.852027219598;9905.405675659484;9910.256730745223;9924.801503970024;9564.378315409476;9632.181264592447;9718.465484398284;9764.170045546067;9830.950845245728;7291.635418229067;7304.415646748247;7319.926800731924;7326;7367.557946523226;7153.928460715326;7162.498625096402;7205.963970180115;7223.133224013152;7265.237150099163;8491.617877195418;8644.524551149747;8792;8805.42764720291;8845.55772211374;8712.39013269065;8717.694880679146;8730.214280714767;8777.868331975153;8968.506732129534;5378.865528361822;6331.2085989251345;6355.777547785805;6372.808815735535;7027.964860175666;7319.63401829917;7341.4860959732305;7376.557406555624;7402.851942961218;7416.443766717625;6241.625502469867;6390.977443609;6421.454176394872;6497.740090396331;6544.116544266463;6061.121137435135;6158.414950579688;6199.225096862892;6213.627182369072;6333.90499142504;6971;7052.0479735235085;7148.4281257500315;7153.070100887059;7158.319959603829;5947.405259474018;6468.676566171578;6547.836304092436;6565.376289252514;6577.177852768404;6367.108604795239;6402.583832050902;6438.839029024124;6443.452306553995;6460.063290822898 11:20:43 INFO - PROCESS | 6625 | |4;prototype.html;333.30838510091564;334.3396791337109;334.790755777639;335.37285276532884;337.22270167264446;5687.345955215152;5699.74351154198;5713.942860571393;5717.914231286523;5747.59766816322;5615.494605485505;5726.226959360495;5734.4265573442635;5739.827805165852;5741.311042674884;4316.589923957219;4414.3378493225955;4436.401085853401;4437.755923424211;4478.305862591304;4434.911301773963;4436.223660859353;4439.378487011821;4442.644588432918;4454.37638730578;4412.073464572443;4412.271975124101;4413.271810151321;4414.955850441503;4419.315006174048;4417.73493590384;4421.005273813398;4424.181526417623;4432.889177770549;4438.778061096932;3875.2636998970106;3879.689624830007;3881.4565960765517;3882.5729169791302;3886;5540.418256083093;5557.972210138963;5564.33228012641;5573.024720673907;5578.609497335188;4877.634177436671;5046.924296135561;5096.694198348111;5104.183330667075;5115.795368185268;6054.697265136726;6072.9696351518405;6078.817635470943;6084.056971169476;6095.238095238095;4160.667146628292;4200.411942328076;4204.2432362174795;4216.746995180299;4226.725262857904;6352.205974253218;6395.328490508523;6409.551331406803;6443.194600674916;6444.452221561173;4314.784260786948;4315.136972605492;4317.266064768934;4317.870463886088;4332.696711230246;4389.253826849444;4391.8462853799965;4392.692511524163;4392.846250381285;4405.7797110144365;4812.8796780080775;4992.226204938241;4998.70007799526;5002.849914502571;5004.924926126111;6037.818865434044;6046.244219472566;6075;6082.60463069899;6094.2077529920825;1536.3316957123463;1556.5875043113583;1558.322129873486;1559.8128224612892;1561.5393458929643;1003.3678782367062;1009.99000999001;1023.9897601024044;1028.236574275107;1034.1468288661883;5379.919301210485;5397.298351214396;5404.297441332602;5408.188771684278;5411.918821217685;6304.590201636879;6306.716197771111;6311.147995020705;6312.67433838899;6318.178636777281;5150.587952963754;5256.369235691665;5387.326584176978;5388.811391601275;5399.082156033483;3383.864645414205;3392.9830350848088;3416.0435078178148;3446.551948246712;3455.568053993251;6079.787207447718;6080.57435979486;6087.117367981707;6102.72537735803;6151.292601350812;6526.107428845677;6533.901991470132;6534.085228068075;6552.049952756824;6552.770653027216;6055;6065.3934606539;6092.8781424372155;6131.84670383244;6150.108234306001;6143.600665956698;6224.221972253468;6290.748370065329;6328.525360598066;6424.421802037839;6236.03341482071;6240.563160578898;6241.594296370721;6245.437910587887;6247.468965137832;6022.427869352405;6022.939770602413;6033.939660603338;6045.6070355426755;6063.787767428119;4290.734233401216;4323.935140972825;4344.826206951687;4349.43457350555;4355.542668019939;6144.662043587646;6156.322804491413;6353.491720662429;6367.363263673596;6396.072569477493;6047.123167140652;6108.4807791338235;6132.141500190066;6147.815565533041;6147.907781383372;6114.052321890114;6115.327313995368;6139.2019037526625;6143.72353244114;6145.231846019247;6009.188759517409;6012.488938440281;6015.2781666200335;6023.548233882389;6029.969850150721;5985.581009329305;6174.475169610633;6185.443310102112;6198.659073750807;6199.16311297969;5969.552283578836;5988.5508586855285;5998.370171131968;6005.159277701038;6006.729697163551 11:20:43 INFO - PROCESS | 6625 | |5;yui.html;577.3187638586469;578.0635370699465;583.2126629050781;590.1590233916668;619.7335145887266;11375.26060806048;11467.827982580258;11547.653570392891;11566.016888564482;11588.710282242948;9916.10755032047;10773.299735517205;10858.565657373696;10910.399928003957;10942;846.8560344741409;860.2730692564772;868.2793281576309;870.7779516223354;873.7946582553095;848.4612271207766;858.7767180533044;860.109786371106;861.5907443964098;862.9223369896708;894.5840184314293;911.1298709732223;912.8493798523269;913.0002647101446;914.634146341462;896.5920506169678;899.554720413393;905.5472263868066;906.3202598051462;907.310444062514;661.110805965975;664.3058004385429;669.712023829753;671.523218514855;676.313541755119;11324.094072474183;11379.089672826236;11426.771464570662;11445.370504622242;11479.713007174803;11174.10607151426;11185.440727963569;11409.14431417647;11460.255083419552;11542.36516991565;9579.281553883488;9622.807543849154;9665.90334096657;9722.75693107678;9742.707718768377;2908.4910140725287;2917.7082291770867;2963.140689200151;2966.332575170591;2996.9400611987858;41243;41315.586844131474;41376.37935430971;41726;42173.789131054145;9609.471479068718;9623.085806848338;9689.51552422376;9705.175060119827;9768.658096966572;16317.18414079315;16410.83589164117;16451;16567.17164141788;16602.50192494227;6124.540659450559;6255.624662520172;6308.936910630927;6346.682665866781;6381.936180638227;3585.8565657373933;3621.6378362163573;3647.6534729200685;3667.3032123896373;3681.7790932544135;2725.2914242296747;2726.1412655014005;2734.8359098454157;2756.186924857172;2765.834049957009;497.2243300451307;499.9100161970807;500.2920866973265;500.4245118114125;501.74411050363847;453.3449165955229;511.103014210059;530.0882482130729;542.1109380615793;552.7844140785097;6922.653867306614;6958.65206739661;6959.0257363969085;6961.23426423093;7025.402840758593;452.983053045914;482.257323721472;499.8250612285671;527.4435470578577;535.6304150136393;3358;3374.1395944034607;3391.1687688647853;3413.7098346640814;3465.376232278214;43509;43816.78091609585;43833.78083109564;43897.34153987693;44058.33912491315;41020.79489602533;41201.381979270336;42359.15281694349;43135;43393.34909976353;37712.81143594265;37881.242375152346;38033.619663804115;39016.609833901864;39281.21437571233;6638.10813918031;6727.966360168363;6810.82972925661;6811.114555107804;6973.19808222061;30607.846960765055;31022;32438;32629.021129366156;33342;39660.80169599134;39954.00114997148;40080.799596003;40252;40856.38715419212;9771.247981454011;9939.916470453561;10598.682039538826;10704.946475267574;10728.785424291627;11541.769164616828;11669.35818529989;11818.881811182122;11944.462499187384;12178.512859485876;10428.322159059637;10615;10670;10820.242583019428;10887.18346124028;10989.61536346224;11057.557697692002;11220.15848811326;11495.54017839277;11556.133290003116;10207.387556746618;10807.35155890649;10842.457877105955;11508.94245528767;11537.653870383901;8216.958915205385;8236.50580965144;8380.287675547646;8627.913720862962;8666.913330866862;8280.378971577034;8598.957005215185;8687.305015598611;8729.738107856774;8785 11:20:43 INFO - PROCESS | 6625 | __end_tp_report 11:20:43 INFO - PROCESS | 6625 | __start_cc_report 11:20:43 INFO - PROCESS | 6625 | _x_x_mozilla_cycle_collect,314 11:20:43 INFO - PROCESS | 6625 | __end_cc_report 11:20:43 INFO - PROCESS | 6625 | __startTimestamp1467224443427__endTimestamp 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | ------- Summary: start ------- 11:20:43 INFO - PROCESS | 6625 | Number of tests: 6 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | [#0] dojo.html Cycles:165 Average:4694.14 Median:4826.98 stddev:457.02 (9.5%) stddev-sans-first:433.47 11:20:43 INFO - PROCESS | 6625 | Values: 2795.4 2846.6 2870.2 2902.0 2914.9 4690.3 4702.0 4704.2 4714.6 4730.7 4681.3 4713.0 4735.6 4744.9 4761.3 4342.5 4363.2 4403.9 4406.4 4432.4 4251.3 4390.4 4398.9 4407.0 4433.4 4421.5 4425.0 4491.8 4512.1 4519.8 4401.4 4404.4 4412.4 4414.1 4433.8 3937.0 4327.2 4371.9 4378.0 4396.5 4612.6 4621.7 4626.1 4666.4 4688.3 5003.4 5021.7 5026.7 5040.2 5073.3 4945.7 5044.8 5122.7 5122.9 5129.9 4704.8 4712.6 4732.5 4741.1 4754.6 5024.2 5167.7 5177.2 5217.2 5245.7 5005.1 5049.7 5067.2 5070.8 5100.4 5043.3 5045.5 5051.8 5054.6 5088.3 4968.9 4986.0 4987.6 4996.1 5040.7 5026.5 5045.7 5070.9 5081.2 5087.4 4307.9 4327.0 4328.6 4333.6 4350.8 3709.4 3766.3 3772.2 3790.9 3819.4 4320.2 4336.0 4386.5 4417.2 4495.1 4928.7 4963.0 4990.7 4998.0 5020.8 4396.0 4408.5 4455.4 4524.0 4550.6 4526.5 4529.0 4538.7 4539.9 4548.5 4840.3 4856.3 4862.6 4864.7 4868.8 4870.4 5089.8 5149.2 5182.5 5187.7 4839.6 4850.5 4863.3 4871.8 4896.8 4841.0 4983.2 4991.6 4999.8 5025.9 5093.1 5132.6 5148.5 5163.1 5186.3 4914.2 4970.9 4976.0 4976.5 5003.0 4737.9 4886.9 4931.6 4988.1 5014.4 4790.3 4793.6 4813.4 4827.0 4856.5 4881.0 4942.2 4942.9 4945.2 4974.6 4739.8 4763.2 4818.4 4846.1 4885.3 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | [#1] ext.html Cycles:180 Average:42080.11 Median:36954.41 stddev:67600.23 (182.9%) stddev-sans-first:67717.68 11:20:43 INFO - PROCESS | 6625 | Values: 474.5 501.4 508.7 509.6 518.7 27023.6 34610.8 34940.0 34966.5 35013.6 37489.6 37900.0 37993.6 38129.4 38266.8 8018.1 8180.2 8191.8 8214.1 8225.9 7833.7 7996.2 8000.4 8030.1 8032.1 7976.1 8031.9 8050.4 8060.8 8061.5 7939.7 8004.4 8011.2 8232.2 8257.9 8123.6 8221.8 8247.7 8270.7 8293.8 39404.4 39473.4 39766.4 39827.2 39834.6 2678.0 2725.6 2810.1 2836.5 3112.6 29567.4 29717.4 29878.9 30078.0 30382.2 3176.2 3215.0 3227.5 3257.9 3297.7 223840.0 224518.0 224656.0 225706.0 226519.0 41033.4 41505.0 58881.0 59381.1 59406.0 43028.0 43491.1 43493.6 43530.3 43610.1 13059.3 13141.6 13217.9 13244.7 13253.2 9510.3 9555.8 9564.4 9570.4 9585.4 14586.4 14660.3 14702.6 14769.3 14806.3 5568.1 5678.8 5699.7 5720.6 5796.3 910.4 936.9 955.5 956.9 990.6 27662.3 27699.4 27951.3 27981.9 28406.4 969.6 971.5 971.9 1015.8 1030.6 14432.6 14872.9 14898.5 15098.0 15100.0 278173.0 281238.0 281859.0 282153.0 283195.0 50808.5 50973.0 51067.5 51118.7 51262.0 1270.5 1313.6 1327.6 1337.0 1340.2 26869.0 27702.3 27986.3 28054.7 28356.6 43778.3 44155.8 44346.0 44469.3 44550.0 267031.0 267320.0 267688.0 268974.0 270173.0 32281.0 32634.0 32941.8 42657.8 43230.0 38186.6 38236.2 38566.8 38825.0 39332.0 36418.5 36588.8 36607.8 36694.3 37087.0 34461.7 36486.0 36532.3 36724.4 36821.8 34189.0 36272.0 37560.2 39744.6 41329.4 31834.7 32505.0 32675.5 32744.5 33031.5 25762.0 25828.5 25858.9 25990.1 26165.7 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | [#2] jquery.html Cycles:180 Average:22242.29 Median:377534.50 stddev:62164.67 (16.5%) stddev-sans-first:62317.33 11:20:43 INFO - PROCESS | 6625 | Values: 352.4 360.0 361.6 363.6 364.7 15546.7 15684.5 17357.5 17447.4 17464.6 14580.1 14698.5 14812.6 14849.9 14875.7 4930.0 4983.1 5164.5 5180.7 5184.9 5019.9 5125.3 5129.5 5150.4 5158.4 4955.2 5101.7 5101.9 5129.4 5138.2 5023.0 5094.2 5105.9 5134.3 5135.7 4565.8 4567.7 4570.3 4577.3 4578.1 19399.1 19611.4 19863.7 20050.4 20109.4 1869.5 1899.7 1960.4 2164.4 2335.7 12744.2 12945.2 13086.5 13357.3 13397.9 1709.8 1772.8 1805.7 1822.7 1843.3 54849.5 55984.7 56113.4 56428.0 56775.4 9012.3 9035.0 9080.9 9165.9 9324.4 12052.8 12059.2 12061.8 12067.6 12082.9 6733.8 6752.7 6794.4 6797.3 6804.5 6435.5 6452.4 6489.4 6493.4 6505.7 5507.4 5580.2 5651.7 5653.3 5657.6 1665.3 1682.8 1683.6 1753.4 1758.2 872.5 896.3 990.2 991.5 1002.1 13701.7 15960.9 16290.9 16937.7 17056.9 912.6 945.8 948.4 957.9 968.8 9632.0 9649.2 9664.0 9949.2 9973.0 377085.0 377984.0 379086.0 381258.0 391321.0 38666.8 42530.8 52187.2 58362.0 59752.7 901.4 901.9 913.9 923.7 937.3 13974.4 14683.9 14857.1 15039.7 15446.7 29450.3 29866.3 30443.1 30526.5 30634.7 33658.5 35225.0 35368.1 35703.3 35864.8 7464.7 7559.0 7661.8 7791.4 7843.9 10864.2 11934.7 11936.8 12030.9 12138.2 10134.6 10466.1 10522.5 10648.1 10960.1 10402.7 10538.5 10601.7 10621.3 10673.7 10560.0 10602.5 10608.2 10627.0 10752.1 7317.6 7492.8 7864.0 7899.1 7939.3 9832.6 10102.6 10141.5 10175.4 10425.5 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | [#3] mootools.html Cycles:180 Average:5355.72 Median:6286.42 stddev:2885.39 (45.9%) stddev-sans-first:2878.42 11:20:43 INFO - PROCESS | 6625 | Values: 1432.8 1461.1 1640.0 1755.4 1834.6 7660.1 7718.3 7817.4 7954.4 7958.4 7503.8 7564.5 7588.1 7601.6 7633.4 2129.7 2152.2 2157.0 2159.3 2170.3 2236.3 2259.2 2259.7 2261.6 2261.7 2195.2 2205.5 2212.5 2215.7 2225.0 2185.5 2196.9 2200.3 2200.6 2202.0 2182.6 2202.7 2223.3 2224.9 2224.9 7636.4 7661.0 7680.5 7686.2 7722.6 4252.9 4354.2 4391.8 4399.2 4401.1 2938.7 3031.2 3081.9 3087.9 3092.6 950.9 982.2 983.0 999.8 1003.7 10573.2 10665.1 10694.8 10700.1 10717.5 4030.3 4047.8 4136.1 4154.2 4185.4 8605.5 8624.3 8632.5 8635.7 8645.0 4528.1 4537.2 4542.3 4545.7 4551.1 3467.3 3995.1 4042.0 4075.4 4088.7 3377.8 3433.3 3435.3 3437.2 3473.0 994.7 997.7 1006.3 1031.1 1033.6 1089.8 1169.7 1176.4 1182.5 1232.2 7253.7 7264.0 7273.5 7286.2 7318.6 463.3 479.4 483.8 488.4 488.4 5461.0 5677.9 5694.7 5710.5 5734.3 9546.5 9864.9 9905.4 9910.3 9924.8 9564.4 9632.2 9718.5 9764.2 9831.0 7291.6 7304.4 7319.9 7326.0 7367.6 7153.9 7162.5 7206.0 7223.1 7265.2 8491.6 8644.5 8792.0 8805.4 8845.6 8712.4 8717.7 8730.2 8777.9 8968.5 5378.9 6331.2 6355.8 6372.8 7028.0 7319.6 7341.5 7376.6 7402.9 7416.4 6241.6 6391.0 6421.5 6497.7 6544.1 6061.1 6158.4 6199.2 6213.6 6333.9 6971.0 7052.0 7148.4 7153.1 7158.3 5947.4 6468.7 6547.8 6565.4 6577.2 6367.1 6402.6 6438.8 6443.5 6460.1 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | [#4] prototype.html Cycles:180 Average:5048.06 Median:5651.42 stddev:1500.59 (26.6%) stddev-sans-first:1462.48 11:20:43 INFO - PROCESS | 6625 | Values: 333.3 334.3 334.8 335.4 337.2 5687.3 5699.7 5713.9 5717.9 5747.6 5615.5 5726.2 5734.4 5739.8 5741.3 4316.6 4414.3 4436.4 4437.8 4478.3 4434.9 4436.2 4439.4 4442.6 4454.4 4412.1 4412.3 4413.3 4415.0 4419.3 4417.7 4421.0 4424.2 4432.9 4438.8 3875.3 3879.7 3881.5 3882.6 3886.0 5540.4 5558.0 5564.3 5573.0 5578.6 4877.6 5046.9 5096.7 5104.2 5115.8 6054.7 6073.0 6078.8 6084.1 6095.2 4160.7 4200.4 4204.2 4216.7 4226.7 6352.2 6395.3 6409.6 6443.2 6444.5 4314.8 4315.1 4317.3 4317.9 4332.7 4389.3 4391.8 4392.7 4392.8 4405.8 4812.9 4992.2 4998.7 5002.8 5004.9 6037.8 6046.2 6075.0 6082.6 6094.2 1536.3 1556.6 1558.3 1559.8 1561.5 1003.4 1010.0 1024.0 1028.2 1034.1 5379.9 5397.3 5404.3 5408.2 5411.9 6304.6 6306.7 6311.1 6312.7 6318.2 5150.6 5256.4 5387.3 5388.8 5399.1 3383.9 3393.0 3416.0 3446.6 3455.6 6079.8 6080.6 6087.1 6102.7 6151.3 6526.1 6533.9 6534.1 6552.0 6552.8 6055.0 6065.4 6092.9 6131.8 6150.1 6143.6 6224.2 6290.7 6328.5 6424.4 6236.0 6240.6 6241.6 6245.4 6247.5 6022.4 6022.9 6033.9 6045.6 6063.8 4290.7 4323.9 4344.8 4349.4 4355.5 6144.7 6156.3 6353.5 6367.4 6396.1 6047.1 6108.5 6132.1 6147.8 6147.9 6114.1 6115.3 6139.2 6143.7 6145.2 6009.2 6012.5 6015.3 6023.5 6030.0 5985.6 6174.5 6185.4 6198.7 6199.2 5969.6 5988.6 5998.4 6005.2 6006.7 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - PROCESS | 6625 | [#5] yui.html Cycles:180 Average:11949.19 Median:43264.17 stddev:13268.73 (30.7%) stddev-sans-first:13278.47 11:20:43 INFO - PROCESS | 6625 | Values: 577.3 578.1 583.2 590.2 619.7 11375.3 11467.8 11547.7 11566.0 11588.7 9916.1 10773.3 10858.6 10910.4 10942.0 846.9 860.3 868.3 870.8 873.8 848.5 858.8 860.1 861.6 862.9 894.6 911.1 912.8 913.0 914.6 896.6 899.6 905.5 906.3 907.3 661.1 664.3 669.7 671.5 676.3 11324.1 11379.1 11426.8 11445.4 11479.7 11174.1 11185.4 11409.1 11460.3 11542.4 9579.3 9622.8 9665.9 9722.8 9742.7 2908.5 2917.7 2963.1 2966.3 2996.9 41243.0 41315.6 41376.4 41726.0 42173.8 9609.5 9623.1 9689.5 9705.2 9768.7 16317.2 16410.8 16451.0 16567.2 16602.5 6124.5 6255.6 6308.9 6346.7 6381.9 3585.9 3621.6 3647.7 3667.3 3681.8 2725.3 2726.1 2734.8 2756.2 2765.8 497.2 499.9 500.3 500.4 501.7 453.3 511.1 530.1 542.1 552.8 6922.7 6958.7 6959.0 6961.2 7025.4 453.0 482.3 499.8 527.4 535.6 3358.0 3374.1 3391.2 3413.7 3465.4 43509.0 43816.8 43833.8 43897.3 44058.3 41020.8 41201.4 42359.2 43135.0 43393.3 37712.8 37881.2 38033.6 39016.6 39281.2 6638.1 6728.0 6810.8 6811.1 6973.2 30607.8 31022.0 32438.0 32629.0 33342.0 39660.8 39954.0 40080.8 40252.0 40856.4 9771.2 9939.9 10598.7 10704.9 10728.8 11541.8 11669.4 11818.9 11944.5 12178.5 10428.3 10615.0 10670.0 10820.2 10887.2 10989.6 11057.6 11220.2 11495.5 11556.1 10207.4 10807.4 10842.5 11508.9 11537.7 8217.0 8236.5 8380.3 8627.9 8666.9 8280.4 8599.0 8687.3 8729.7 8785.0 11:20:43 INFO - PROCESS | 6625 | -------- Summary: end -------- 11:20:43 INFO - PROCESS | 6625 | 11:20:43 INFO - TEST-INFO | 6625: exit 0 11:20:43 INFO - TEST-OK | dromaeo_css | took 1112572ms 11:20:43 INFO - TEST-START | kraken 11:20:43 INFO - operating with platform_type : linux_ 11:20:43 INFO - Initialising browser for kraken test... 11:20:43 INFO - TEST-INFO | started process 6866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr8T_br/profile http://localhost:51843/getInfo.html) 11:20:47 INFO - PROCESS | 6866 | 11:20:47 INFO - PROCESS | 6866 | (process:6941): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:20:48 INFO - PROCESS | 6866 | __metrics Screen width/height:1600/1200 11:20:48 INFO - PROCESS | 6866 | colorDepth:24 11:20:48 INFO - PROCESS | 6866 | Browser inner width/height: 1024/697 11:20:48 INFO - PROCESS | 6866 | __metrics 11:20:49 ERROR - PROCESS | 6866 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 11:20:49 INFO - TEST-INFO | 6866: exit 0 11:20:49 INFO - Browser initialized. 11:20:49 INFO - Running cycle 1/1 for kraken test... 11:20:49 INFO - TEST-INFO | started process 6991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr8T_br/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:51 INFO - PROCESS | 6991 | 11:20:51 INFO - PROCESS | 6991 | (process:7060): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:21:01 INFO - PROCESS | 6991 | RSS: Main: 149512192 11:21:01 INFO - PROCESS | 6991 | 11:21:04 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51843/tests/kraken/driver.html?testName=audio-beat-detection) 11:21:05 INFO - PROCESS | 6991 | RSS: Main: 153518080 11:21:05 INFO - PROCESS | 6991 | 11:21:07 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51843/tests/kraken/driver.html?testName=audio-dft) 11:21:08 INFO - PROCESS | 6991 | RSS: Main: 153706496 11:21:08 INFO - PROCESS | 6991 | 11:21:11 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51843/tests/kraken/driver.html?testName=audio-fft) 11:21:11 INFO - PROCESS | 6991 | RSS: Main: 153964544 11:21:11 INFO - PROCESS | 6991 | 11:21:13 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51843/tests/kraken/driver.html?testName=audio-oscillator) 11:21:14 INFO - PROCESS | 6991 | RSS: Main: 153640960 11:21:14 INFO - PROCESS | 6991 | 11:21:16 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:17 INFO - PROCESS | 6991 | RSS: Main: 154136576 11:21:17 INFO - PROCESS | 6991 | 11:21:20 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51843/tests/kraken/driver.html?testName=imaging-darkroom) 11:21:21 INFO - PROCESS | 6991 | RSS: Main: 153894912 11:21:21 INFO - PROCESS | 6991 | 11:21:24 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51843/tests/kraken/driver.html?testName=imaging-desaturate) 11:21:25 INFO - PROCESS | 6991 | RSS: Main: 154066944 11:21:25 INFO - PROCESS | 6991 | 11:21:28 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51843/tests/kraken/driver.html?testName=json-parse-financial) 11:21:28 INFO - PROCESS | 6991 | RSS: Main: 154071040 11:21:28 INFO - PROCESS | 6991 | 11:21:30 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:31 INFO - PROCESS | 6991 | RSS: Main: 154251264 11:21:31 INFO - PROCESS | 6991 | 11:21:32 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51843/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:33 INFO - PROCESS | 6991 | RSS: Main: 154357760 11:21:33 INFO - PROCESS | 6991 | 11:21:35 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:36 INFO - PROCESS | 6991 | RSS: Main: 154779648 11:21:36 INFO - PROCESS | 6991 | 11:21:38 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:21:39 INFO - PROCESS | 6991 | RSS: Main: 154624000 11:21:39 INFO - PROCESS | 6991 | 11:21:41 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:21:42 INFO - PROCESS | 6991 | RSS: Main: 154861568 11:21:42 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | Cycle 1(1): loaded http://localhost:51843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51843/tests/kraken/driver.html?testName=ai-astar) 11:21:44 INFO - PROCESS | 6991 | RSS: Main: 156364800 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | __start_tp_report 11:21:44 INFO - PROCESS | 6991 | _x_x_mozilla_page_load 11:21:44 INFO - PROCESS | 6991 | _x_x_mozilla_page_load_details 11:21:44 INFO - PROCESS | 6991 | |i|pagename|runs| 11:21:44 INFO - PROCESS | 6991 | |0;ai-astar;112;115;105;116;113;114;104;115;112;116 11:21:44 INFO - PROCESS | 6991 | |1;audio-beat-detection;156;137;156;180;140;164;158;134;178;133 11:21:44 INFO - PROCESS | 6991 | |2;audio-dft;162;161;162;162;162;161;161;163;161;162 11:21:44 INFO - PROCESS | 6991 | |3;audio-fft;74;77;74;153;77;78;74;74;167;78 11:21:44 INFO - PROCESS | 6991 | |4;audio-oscillator;93;95;134;95;95;94;140;94;94;141 11:21:44 INFO - PROCESS | 6991 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;117;118;118 11:21:44 INFO - PROCESS | 6991 | |6;imaging-darkroom;147;148;147;148;146;148;147;147;147;147 11:21:44 INFO - PROCESS | 6991 | |7;imaging-desaturate;95;96;97;96;96;95;95;97;95;96 11:21:44 INFO - PROCESS | 6991 | |8;json-parse-financial;68;72;68;74;70;70;71;69;75;70 11:21:44 INFO - PROCESS | 6991 | |9;json-stringify-tinderbox;65;64;64;65;65;64;65;65;65;65 11:21:44 INFO - PROCESS | 6991 | |10;stanford-crypto-aes;79;81;90;81;81;81;82;82;81;88 11:21:44 INFO - PROCESS | 6991 | |11;stanford-crypto-ccm;127;125;126;120;126;131;119;130;123;117 11:21:44 INFO - PROCESS | 6991 | |12;stanford-crypto-pbkdf2;145;145;145;131;143;144;145;155;132;144 11:21:44 INFO - PROCESS | 6991 | |13;stanford-crypto-sha256-iterative;70;71;70;69;67;69;68;69;67;67 11:21:44 INFO - PROCESS | 6991 | __end_tp_report 11:21:44 INFO - PROCESS | 6991 | __start_cc_report 11:21:44 INFO - PROCESS | 6991 | _x_x_mozilla_cycle_collect,898 11:21:44 INFO - PROCESS | 6991 | __end_cc_report 11:21:44 INFO - PROCESS | 6991 | __startTimestamp1467224504447__endTimestamp 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | ------- Summary: start ------- 11:21:44 INFO - PROCESS | 6991 | Number of tests: 14 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#0] ai-astar Cycles:10 Average:112.20 Median:114.50 stddev:4.32 (3.8%) stddev-sans-first:4.58 11:21:44 INFO - PROCESS | 6991 | Values: 112.0 115.0 105.0 116.0 113.0 114.0 104.0 115.0 112.0 116.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:157.00 stddev:17.32 (11.0%) stddev-sans-first:18.35 11:21:44 INFO - PROCESS | 6991 | Values: 156.0 137.0 156.0 180.0 140.0 164.0 158.0 134.0 178.0 133.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:21:44 INFO - PROCESS | 6991 | Values: 162.0 161.0 162.0 162.0 162.0 161.0 161.0 163.0 161.0 162.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.50 stddev:35.72 (47.3%) stddev-sans-first:37.24 11:21:44 INFO - PROCESS | 6991 | Values: 74.0 77.0 74.0 153.0 77.0 78.0 74.0 74.0 167.0 78.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:94.00 stddev:21.36 (22.7%) stddev-sans-first:22.00 11:21:44 INFO - PROCESS | 6991 | Values: 93.0 95.0 134.0 95.0 95.0 94.0 140.0 94.0 94.0 141.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:21:44 INFO - PROCESS | 6991 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 118.0 118.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 11:21:44 INFO - PROCESS | 6991 | Values: 147.0 148.0 147.0 148.0 146.0 148.0 147.0 147.0 147.0 147.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 11:21:44 INFO - PROCESS | 6991 | Values: 95.0 96.0 97.0 96.0 96.0 95.0 95.0 97.0 95.0 96.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.50 stddev:2.36 (3.3%) stddev-sans-first:2.29 11:21:44 INFO - PROCESS | 6991 | Values: 68.0 72.0 68.0 74.0 70.0 70.0 71.0 69.0 75.0 70.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:21:44 INFO - PROCESS | 6991 | Values: 65.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:81.50 stddev:3.50 (4.3%) stddev-sans-first:3.46 11:21:44 INFO - PROCESS | 6991 | Values: 79.0 81.0 90.0 81.0 81.0 81.0 82.0 82.0 81.0 88.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.00 stddev:4.62 (3.7%) stddev-sans-first:4.81 11:21:44 INFO - PROCESS | 6991 | Values: 127.0 125.0 126.0 120.0 126.0 131.0 119.0 130.0 123.0 117.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:145.00 stddev:6.89 (4.7%) stddev-sans-first:7.26 11:21:44 INFO - PROCESS | 6991 | Values: 145.0 145.0 145.0 131.0 143.0 144.0 145.0 155.0 132.0 144.0 11:21:44 INFO - PROCESS | 6991 | 11:21:44 INFO - PROCESS | 6991 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.42 (2.1%) stddev-sans-first:1.42 11:21:44 INFO - PROCESS | 6991 | Values: 70.0 71.0 70.0 69.0 67.0 69.0 68.0 69.0 67.0 67.0 11:21:44 INFO - PROCESS | 6991 | -------- Summary: end -------- 11:21:44 INFO - PROCESS | 6991 | 11:21:45 INFO - TEST-INFO | 6991: exit 0 11:21:45 INFO - TEST-OK | kraken | took 61267ms 11:21:45 INFO - SUITE-END | took 1173s 11:21:45 INFO - Completed test suite (00:19:34) 11:21:45 INFO - javascript benchmark 11:21:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2795.3989892173186, 2846.587244849496, 2870.210692059685, 2901.970980290198, 2914.927126821829, 4690.343351930733, 4701.976490117553, 4704.247320428732, 4714.599259062979, 4730.692504987173, 4681.274402467615, 4713.0, 4735.644826637998, 4744.90510189796, 4761.285807128932, 4342.457192850894, 4363.236433624119, 4403.911921761563, 4406.427164468614, 4432.445944256968, 4251.277282861905, 4390.385346051556, 4398.934015989763, 4406.955930440703, 4433.401490798749, 4421.513633500313, 4425.0, 4491.842785502508, 4512.052468981501, 4519.819207231707, 4401.405810215628, 4404.427424434835, 4412.426384570017, 4414.073044660625, 4433.756143412111, 3936.980315098435, 4327.177836211141, 4371.890702732426, 4378.036831896978, 4396.516383197878, 4612.58486736192, 4621.69958952667, 4626.121037002992, 4666.440027196724, 4688.343631891538, 5003.449620541737, 5021.6735912165595, 5026.6983980960895, 5040.218766091225, 5073.289739436482, 4945.727984960826, 5044.823431179928, 5122.667026643257, 5122.92315615266, 5129.8717532062, 4704.811807527695, 4712.575868171881, 4732.455767586737, 4741.099191153669, 4754.619630429626, 5024.2463630454995, 5167.6641018333685, 5177.249298851721, 5217.165253559412, 5245.737713114329, 5005.1241032819835, 5049.722265275445, 5067.239914012854, 5070.797168113308, 5100.387953445536, 5043.293938848564, 5045.520675535819, 5051.772670229849, 5054.620903432184, 5088.262201980692, 4968.925466118011, 4985.950140498621, 4987.600991920638, 4996.075725990703, 5040.672356296829, 5026.547610715053, 5045.697258164522, 5070.898582028339, 5081.23781432788, 5087.440381558025, 4307.9445535843915, 4326.978365108154, 4328.632066274402, 4333.58830911063, 4350.825966961286, 3709.3694072007283, 3766.303233901737, 3772.245550889833, 3790.9241815164096, 3819.388897776398, 4320.179165958458, 4336.046069864625, 4386.495553011381, 4417.249067658506, 4495.145922274757, 4928.7289199093675, 4962.950370496321, 4990.700557966461, 4997.9750101249265, 5020.849374518771, 4395.956040439554, 4408.493023302297, 4455.443069616298, 4524.0, 4550.567696068868, 4526.479454862667, 4529.048899731028, 4538.72767633943, 4539.886502837456, 4548.476925153584, 4840.298156767249, 4856.295837103671, 4862.610991120772, 4864.73243971585, 4868.780904859361, 4870.391201099863, 5089.847304580869, 5149.201873709581, 5182.455842136672, 5187.662801917863, 4839.612830973584, 4850.46644869057, 4863.294822250683, 4871.805127794849, 4896.804127834846, 4840.975795121143, 4983.177775666974, 4991.625628077982, 4999.800007999639, 5025.924611130909, 5093.1341671915125, 5132.615053871049, 5148.536631703165, 5163.09645811989, 5186.273921651047, 4914.213725803854, 4970.900581988412, 4976.029674213639, 4976.452590215001, 5003.0, 4737.881552961066, 4886.853394398174, 4931.580815630568, 4988.102141614544, 5014.448410674896, 4790.305405716222, 4793.592544633745, 4813.3983252093485, 4826.975865120792, 4856.490068542894, 4881.048195601824, 4942.1598328285, 4942.8764280893265, 4945.23348880924, 4974.552290293891, 4739.810407583658, 4763.2378819390115, 4818.397700287464, 4846.079244943449, 4885.267209918541], "unit": "score", "name": "dojo.html", "value": 4668.155839826201}, {"lowerIsBetter": false, "replicates": [474.4580114627463, 501.388306266355, 508.7456271864068, 509.60505608153676, 518.6628691350621, 27023.5946460803, 34610.826945865265, 34940.0, 34966.47550286748, 35013.64986350139, 37489.62510374896, 37900.0, 37993.62006379935, 38129.42805857914, 38266.8086659567, 8018.0779210390965, 8180.181981801802, 8191.754247372588, 8214.13751556087, 8225.876611850827, 7833.725819596315, 7996.160403157672, 8000.439969202158, 8030.076541197749, 8032.1164671886045, 7976.082750483711, 8031.915691381676, 8050.355971522294, 8060.798480037987, 8061.4760040597175, 7939.722109726161, 8004.439689221756, 8011.158828323029, 8232.17678232178, 8257.876131858027, 8123.634436450374, 8221.79445513867, 8247.711330103477, 8270.710525131652, 8293.792655183608, 39404.40893386601, 39473.40789888154, 39766.40350394746, 39827.20345593101, 39834.60165398367, 2678.0, 2725.6047873058296, 2810.1007677543193, 2836.517791975369, 3112.579801726783, 29567.40865182684, 29717.405651886842, 29878.85060574705, 30078.0, 30382.240443988856, 3176.2059485128716, 3215.0, 3227.4674678678225, 3257.9022629321157, 3297.670232976707, 223840.0, 224518.0, 224656.0, 225706.0, 226519.0, 41033.38449923253, 41505.0, 58881.0, 59381.10928336078, 59406.0, 43028.0, 43491.13017739628, 43493.56506434958, 43530.347044794355, 43610.12779744387, 13059.281739504419, 13141.605751827461, 13217.933910330386, 13244.73510529784, 13253.204807711569, 9510.33427660071, 9555.808883822285, 9564.378315409476, 9570.377925434825, 9585.376950498196, 14586.41654333836, 14660.340284687214, 14702.55892323232, 14769.261536923112, 14806.333714982851, 5568.109102543654, 5678.835838653066, 5699.686517241508, 5720.570957178228, 5796.333421656564, 910.4264313482464, 936.9109934556343, 955.507913424587, 956.8803899512561, 990.6334656177261, 27662.3084422887, 27699.446011079664, 27951.301217469318, 27981.86009069982, 28406.431871362456, 969.5879251318162, 971.5093877591771, 971.9076687714655, 1015.7968406318765, 1030.5877648940484, 14432.639184020274, 14872.851271487363, 14898.478553250585, 15098.0, 15100.0, 278173.0, 281238.0, 281859.0, 282153.0, 283195.0, 50808.49191508112, 50973.0, 51067.489325106275, 51118.74440627773, 51262.0, 1270.5489551209373, 1313.5599574142768, 1327.634900402397, 1336.9598912032654, 1340.2092765268537, 26869.0, 27702.307442314104, 27986.300342491602, 28054.71945280521, 28356.574651379833, 43778.343324850786, 44155.77922110369, 44346.0, 44469.33296000627, 44550.0, 267031.0, 267320.0, 267688.0, 268974.0, 270173.0, 32281.0, 32634.0, 32941.835290823394, 42657.78671106625, 43230.0, 38186.618133819415, 38236.23527529378, 38566.80716596399, 38825.0, 39332.0, 36418.45372319364, 36588.81705591455, 36607.81696091503, 36694.266114677026, 37087.0, 34461.65538344585, 36486.0, 36532.269354613294, 36724.44913326249, 36821.81589092038, 34189.0, 36272.0, 37560.24879502449, 39744.602553975245, 41329.380059299736, 31834.6816531841, 32505.0, 32675.509867351535, 32744.50883236801, 33031.50452743163, 25762.0, 25828.483430331664, 25858.87070564635, 25990.121150080937, 26165.73834261633], "unit": "score", "name": "ext.html", "value": 16984.050275244364}, {"lowerIsBetter": false, "replicates": [352.35519000229584, 359.9982000089999, 361.6365552619617, 363.5746176972941, 364.72281066389536, 15546.689066218683, 15684.529464116065, 17357.479275621736, 17447.389341373055, 17464.563385915357, 14580.052296600714, 14698.485553005621, 14812.6296842579, 14849.925750371232, 14875.702485950302, 4929.950700493003, 4983.103041452537, 5164.535191832734, 5180.6891586504935, 5184.922226166611, 5019.8705291309525, 5125.333706618135, 5129.461406552315, 5150.407703114152, 5158.3552055993005, 4955.231939049453, 5101.744912754366, 5101.948980510185, 5129.4357620661885, 5138.177891537355, 5023.045621331954, 5094.2103973884105, 5105.872353191163, 5134.332536770196, 5135.691858488484, 4565.771711414416, 4567.6574256930535, 4570.337301091323, 4577.267637178069, 4578.084383123389, 19399.127039283125, 19611.411657650293, 19863.708858924125, 20050.398488045237, 20109.39671809848, 1869.5419622192514, 1899.705545640428, 1960.4216756056996, 2164.3615133535645, 2335.719713634358, 12744.171628844095, 12945.223286602833, 13086.476540938445, 13357.332133393389, 13397.933010334984, 1709.794824621041, 1772.787265528132, 1805.6840052990806, 1822.662807380639, 1843.3456123076248, 54849.45150548483, 55984.72007639936, 56113.43886561123, 56428.0, 56775.432245677424, 9012.324075694349, 9035.00614932357, 9080.909190908138, 9165.862512062324, 9324.440533568008, 12052.758944821055, 12059.155859089955, 12061.75876482483, 12067.577634782916, 12082.939585302018, 6733.764318248838, 6752.729890804411, 6794.3545363190415, 6797.286284940109, 6804.489663275274, 6435.517336199804, 6452.387023232785, 6489.415952564292, 6493.415592596689, 6505.739770409131, 5507.366652834895, 5580.190872323572, 5651.689157096399, 5653.265075540154, 5657.57568182388, 1665.3421898350084, 1682.7644129821836, 1683.6380178261732, 1753.4476639858403, 1758.2263803926232, 872.4983134697575, 896.2740180453853, 990.2375171118342, 991.5290237137447, 1002.1481740520645, 13701.725965480635, 15960.920195398949, 16290.941088829188, 16937.661246774995, 17056.914715426345, 912.6486302773347, 945.7919257763418, 948.3503799897093, 957.875476188105, 968.8449848024283, 9631.951840240894, 9649.228061755182, 9664.0, 9949.204063674888, 9972.9528399517, 377085.0, 377984.0, 379086.0, 381258.0, 391321.0, 38666.80666596649, 42530.78734606369, 52187.21719174215, 58362.0, 59752.70123649441, 901.3510272603846, 901.9413738107002, 913.9497327647043, 923.7228831350702, 937.2501998401252, 13974.441022358991, 14683.853161468249, 14857.108573485626, 15039.699206015599, 15446.691066178839, 29450.263743406587, 29866.253343666584, 30443.086707398812, 30526.542101868934, 30634.693653063183, 33658.49512257367, 35225.0, 35368.11579710528, 35703.28593428169, 35864.82067589645, 7464.701411943462, 7559.0, 7661.846763064596, 7791.415643826849, 7843.921560784547, 10864.185186110915, 11934.701632459259, 11936.76126477483, 12030.939845300718, 12138.211016283913, 10134.6452874152, 10466.058054775107, 10522.473876306307, 10648.148148148284, 10960.068394186583, 10402.687919362432, 10538.525766340379, 10601.734956626146, 10621.309614875008, 10673.679789606324, 10560.0, 10602.46987650599, 10608.151347892304, 10627.0, 10752.08607268391, 7317.597532135784, 7492.812679683051, 7864.0, 7899.131095579596, 7939.28546430824, 9832.60669573209, 10102.646407376, 10141.543630536496, 10175.389476631426, 10425.478726063515], "unit": "score", "name": "jquery.html", "value": 7914.708286073891}, {"lowerIsBetter": false, "replicates": [1432.756431406661, 1461.1087236785559, 1639.959001024975, 1755.4207111653157, 1834.5780470491786, 7660.119086305062, 7718.343940765035, 7817.413693972946, 7954.40341974352, 7958.3633309335255, 7503.812404689886, 7564.470487065908, 7588.127365352986, 7601.581912994797, 7633.351165150955, 2129.7124888140097, 2152.2467136502178, 2156.9892150539304, 2159.265849611132, 2170.251263314154, 2236.3291012696127, 2259.175400978639, 2259.6836442898007, 2261.5589959957815, 2261.739899911515, 2195.19875245535, 2205.5368372641765, 2212.4579478027827, 2215.656573231152, 2225.020990764067, 2185.530111026129, 2196.8572042817245, 2200.3179014505554, 2200.5696297406653, 2201.9779802202092, 2182.5962196993605, 2202.680611311367, 2223.288547664748, 2224.8887555622314, 2224.922127725522, 7636.3890888728765, 7661.0, 7680.462367634268, 7686.1929497402525, 7722.575258360788, 4252.936205956913, 4354.238008348558, 4391.758453285068, 4399.164158809848, 4401.053773438726, 2938.6646156612187, 3031.181580973147, 3081.9229519261976, 3087.9073627791204, 3092.5515800208846, 950.8763860698065, 982.2191357870439, 982.9950850245774, 999.7650552120245, 1003.7390278527563, 10573.20700947432, 10665.093467055309, 10694.786104277871, 10700.143988480902, 10717.46412679363, 4030.3148464760475, 4047.838086476508, 4136.131412403369, 4154.189932963043, 4185.372194170899, 8605.483670979762, 8624.310055195569, 8632.525211113323, 8635.654573816977, 8645.049044605088, 4528.139653465831, 4537.2059889519205, 4542.273236282179, 4545.704529205591, 4551.112533056023, 3467.3065386922717, 3995.081131339808, 4041.9797901010893, 4075.3886916962692, 4088.713790034669, 3377.8142202178624, 3433.261848702491, 3435.278591495764, 3437.2438063625964, 3473.044912648991, 994.7165057958592, 997.680742162501, 1006.285537268533, 1031.0874875734878, 1033.5917312661607, 1089.7765957978754, 1169.7192673758236, 1176.3588844079825, 1182.456070207714, 1232.186756740547, 7253.709851605982, 7263.963680181671, 7273.490855640161, 7286.162091359562, 7318.560886346836, 463.3304874456378, 479.35526716566164, 483.835495931385, 488.3529323646183, 488.3529323646183, 5461.0, 5677.914831277534, 5694.715264236772, 5710.486056254957, 5734.340550836707, 9546.522673866279, 9864.852027219598, 9905.405675659484, 9910.256730745223, 9924.801503970024, 9564.378315409476, 9632.181264592447, 9718.465484398284, 9764.170045546067, 9830.950845245728, 7291.635418229067, 7304.415646748247, 7319.926800731924, 7326.0, 7367.557946523226, 7153.928460715326, 7162.498625096402, 7205.963970180115, 7223.133224013152, 7265.237150099163, 8491.617877195418, 8644.524551149747, 8792.0, 8805.42764720291, 8845.55772211374, 8712.39013269065, 8717.694880679146, 8730.214280714767, 8777.868331975153, 8968.506732129534, 5378.865528361822, 6331.2085989251345, 6355.777547785805, 6372.808815735535, 7027.964860175666, 7319.63401829917, 7341.4860959732305, 7376.557406555624, 7402.851942961218, 7416.443766717625, 6241.625502469867, 6390.977443609, 6421.454176394872, 6497.740090396331, 6544.116544266463, 6061.121137435135, 6158.414950579688, 6199.225096862892, 6213.627182369072, 6333.90499142504, 6971.0, 7052.0479735235085, 7148.4281257500315, 7153.070100887059, 7158.319959603829, 5947.405259474018, 6468.676566171578, 6547.836304092436, 6565.376289252514, 6577.177852768404, 6367.108604795239, 6402.583832050902, 6438.839029024124, 6443.452306553995, 6460.063290822898], "unit": "score", "name": "mootools.html", "value": 4286.957223854488}, {"lowerIsBetter": false, "replicates": [333.30838510091564, 334.3396791337109, 334.790755777639, 335.37285276532884, 337.22270167264446, 5687.345955215152, 5699.74351154198, 5713.942860571393, 5717.914231286523, 5747.59766816322, 5615.494605485505, 5726.226959360495, 5734.4265573442635, 5739.827805165852, 5741.311042674884, 4316.589923957219, 4414.3378493225955, 4436.401085853401, 4437.755923424211, 4478.305862591304, 4434.911301773963, 4436.223660859353, 4439.378487011821, 4442.644588432918, 4454.37638730578, 4412.073464572443, 4412.271975124101, 4413.271810151321, 4414.955850441503, 4419.315006174048, 4417.73493590384, 4421.005273813398, 4424.181526417623, 4432.889177770549, 4438.778061096932, 3875.2636998970106, 3879.689624830007, 3881.4565960765517, 3882.5729169791302, 3886.0, 5540.418256083093, 5557.972210138963, 5564.33228012641, 5573.024720673907, 5578.609497335188, 4877.634177436671, 5046.924296135561, 5096.694198348111, 5104.183330667075, 5115.795368185268, 6054.697265136726, 6072.9696351518405, 6078.817635470943, 6084.056971169476, 6095.238095238095, 4160.667146628292, 4200.411942328076, 4204.2432362174795, 4216.746995180299, 4226.725262857904, 6352.205974253218, 6395.328490508523, 6409.551331406803, 6443.194600674916, 6444.452221561173, 4314.784260786948, 4315.136972605492, 4317.266064768934, 4317.870463886088, 4332.696711230246, 4389.253826849444, 4391.8462853799965, 4392.692511524163, 4392.846250381285, 4405.7797110144365, 4812.8796780080775, 4992.226204938241, 4998.70007799526, 5002.849914502571, 5004.924926126111, 6037.818865434044, 6046.244219472566, 6075.0, 6082.60463069899, 6094.2077529920825, 1536.3316957123463, 1556.5875043113583, 1558.322129873486, 1559.8128224612892, 1561.5393458929643, 1003.3678782367062, 1009.99000999001, 1023.9897601024044, 1028.236574275107, 1034.1468288661883, 5379.919301210485, 5397.298351214396, 5404.297441332602, 5408.188771684278, 5411.918821217685, 6304.590201636879, 6306.716197771111, 6311.147995020705, 6312.67433838899, 6318.178636777281, 5150.587952963754, 5256.369235691665, 5387.326584176978, 5388.811391601275, 5399.082156033483, 3383.864645414205, 3392.9830350848088, 3416.0435078178148, 3446.551948246712, 3455.568053993251, 6079.787207447718, 6080.57435979486, 6087.117367981707, 6102.72537735803, 6151.292601350812, 6526.107428845677, 6533.901991470132, 6534.085228068075, 6552.049952756824, 6552.770653027216, 6055.0, 6065.3934606539, 6092.8781424372155, 6131.84670383244, 6150.108234306001, 6143.600665956698, 6224.221972253468, 6290.748370065329, 6328.525360598066, 6424.421802037839, 6236.03341482071, 6240.563160578898, 6241.594296370721, 6245.437910587887, 6247.468965137832, 6022.427869352405, 6022.939770602413, 6033.939660603338, 6045.6070355426755, 6063.787767428119, 4290.734233401216, 4323.935140972825, 4344.826206951687, 4349.43457350555, 4355.542668019939, 6144.662043587646, 6156.322804491413, 6353.491720662429, 6367.363263673596, 6396.072569477493, 6047.123167140652, 6108.4807791338235, 6132.141500190066, 6147.815565533041, 6147.907781383372, 6114.052321890114, 6115.327313995368, 6139.2019037526625, 6143.72353244114, 6145.231846019247, 6009.188759517409, 6012.488938440281, 6015.2781666200335, 6023.548233882389, 6029.969850150721, 5985.581009329305, 6174.475169610633, 6185.443310102112, 6198.659073750807, 6199.16311297969, 5969.552283578836, 5988.5508586855285, 5998.370171131968, 6005.159277701038, 6006.729697163551], "unit": "score", "name": "prototype.html", "value": 4564.922492279222}, {"lowerIsBetter": false, "replicates": [577.3187638586469, 578.0635370699465, 583.2126629050781, 590.1590233916668, 619.7335145887266, 11375.26060806048, 11467.827982580258, 11547.653570392891, 11566.016888564482, 11588.710282242948, 9916.10755032047, 10773.299735517205, 10858.565657373696, 10910.399928003957, 10942.0, 846.8560344741409, 860.2730692564772, 868.2793281576309, 870.7779516223354, 873.7946582553095, 848.4612271207766, 858.7767180533044, 860.109786371106, 861.5907443964098, 862.9223369896708, 894.5840184314293, 911.1298709732223, 912.8493798523269, 913.0002647101446, 914.634146341462, 896.5920506169678, 899.554720413393, 905.5472263868066, 906.3202598051462, 907.310444062514, 661.110805965975, 664.3058004385429, 669.712023829753, 671.523218514855, 676.313541755119, 11324.094072474183, 11379.089672826236, 11426.771464570662, 11445.370504622242, 11479.713007174803, 11174.10607151426, 11185.440727963569, 11409.14431417647, 11460.255083419552, 11542.36516991565, 9579.281553883488, 9622.807543849154, 9665.90334096657, 9722.75693107678, 9742.707718768377, 2908.4910140725287, 2917.7082291770867, 2963.140689200151, 2966.332575170591, 2996.9400611987858, 41243.0, 41315.586844131474, 41376.37935430971, 41726.0, 42173.789131054145, 9609.471479068718, 9623.085806848338, 9689.51552422376, 9705.175060119827, 9768.658096966572, 16317.18414079315, 16410.83589164117, 16451.0, 16567.17164141788, 16602.50192494227, 6124.540659450559, 6255.624662520172, 6308.936910630927, 6346.682665866781, 6381.936180638227, 3585.8565657373933, 3621.6378362163573, 3647.6534729200685, 3667.3032123896373, 3681.7790932544135, 2725.2914242296747, 2726.1412655014005, 2734.8359098454157, 2756.186924857172, 2765.834049957009, 497.2243300451307, 499.9100161970807, 500.2920866973265, 500.4245118114125, 501.74411050363847, 453.3449165955229, 511.103014210059, 530.0882482130729, 542.1109380615793, 552.7844140785097, 6922.653867306614, 6958.65206739661, 6959.0257363969085, 6961.23426423093, 7025.402840758593, 452.983053045914, 482.257323721472, 499.8250612285671, 527.4435470578577, 535.6304150136393, 3358.0, 3374.1395944034607, 3391.1687688647853, 3413.7098346640814, 3465.376232278214, 43509.0, 43816.78091609585, 43833.78083109564, 43897.34153987693, 44058.33912491315, 41020.79489602533, 41201.381979270336, 42359.15281694349, 43135.0, 43393.34909976353, 37712.81143594265, 37881.242375152346, 38033.619663804115, 39016.609833901864, 39281.21437571233, 6638.10813918031, 6727.966360168363, 6810.82972925661, 6811.114555107804, 6973.19808222061, 30607.846960765055, 31022.0, 32438.0, 32629.021129366156, 33342.0, 39660.80169599134, 39954.00114997148, 40080.799596003, 40252.0, 40856.38715419212, 9771.247981454011, 9939.916470453561, 10598.682039538826, 10704.946475267574, 10728.785424291627, 11541.769164616828, 11669.35818529989, 11818.881811182122, 11944.462499187384, 12178.512859485876, 10428.322159059637, 10615.0, 10670.0, 10820.242583019428, 10887.18346124028, 10989.61536346224, 11057.557697692002, 11220.15848811326, 11495.54017839277, 11556.133290003116, 10207.387556746618, 10807.35155890649, 10842.457877105955, 11508.94245528767, 11537.653870383901, 8216.958915205385, 8236.50580965144, 8380.287675547646, 8627.913720862962, 8666.913330866862, 8280.378971577034, 8598.957005215185, 8687.305015598611, 8729.738107856774, 8785.0], "unit": "score", "name": "yui.html", "value": 5626.828940059924}], "name": "dromaeo_css", "value": 6405.966832964146}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 105.0, 116.0, 113.0, 114.0, 104.0, 115.0, 112.0, 116.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [156.0, 137.0, 156.0, 180.0, 140.0, 164.0, 158.0, 134.0, 178.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 153.6}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 74.0, 153.0, 77.0, 78.0, 74.0, 74.0, 167.0, 78.0], "unit": "score", "name": "audio-fft", "value": 92.6}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 134.0, 95.0, 95.0, 94.0, 140.0, 94.0, 94.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 148.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 68.0, 74.0, 70.0, 70.0, 71.0, 69.0, 75.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 90.0, 81.0, 81.0, 81.0, 82.0, 82.0, 81.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [127.0, 125.0, 126.0, 120.0, 126.0, 131.0, 119.0, 130.0, 123.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 131.0, 143.0, 144.0, 145.0, 155.0, 132.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 69.0, 67.0, 69.0, 68.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1541.8000000000002}]} 11:21:45 INFO - Return code: 0 11:21:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:21:45 ERROR - # TBPL SUCCESS # 11:21:45 INFO - Running post-action listener: _resource_record_post_action 11:21:45 INFO - Running post-run listener: _resource_record_post_run 11:21:46 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 36864; Write bytes: 354705408; Read time: 40; Write time: 229064 11:21:46 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 109948928; Read time: 0; Write time: 118996 11:21:46 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 244756480; Read time: 20; Write time: 110068 11:21:46 INFO - Running post-run listener: _upload_blobber_files 11:21:46 INFO - Blob upload gear active. 11:21:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:21:46 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 11:21:46 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:21:46 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:21:47 INFO - (blobuploader) - INFO - Open directory for files ... 11:21:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:21:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:21:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:48 INFO - (blobuploader) - INFO - Done attempting. 11:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:21:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:21:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:21:48 INFO - (blobuploader) - INFO - Done attempting. 11:21:48 INFO - (blobuploader) - INFO - Iteration through files over. 11:21:48 INFO - Return code: 0 11:21:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:21:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:21:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/11c9575fbd4df4b64985f67574d5ddbc455843a9317cb9baabc8c6a99633b328dc1bf74870de048c185c9fa65a61f1d34076374d091aee82d3d319ea1400c2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/200b0ffb77b6152da422a68b24c601754744bf1b5166d95a6555d9113c90b72c10be888933e6c8ea3ab4bbf96036341fa4d193426222b90ffd487c1ee408ae2b"} 11:21:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:21:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:21:48 INFO - Contents: 11:21:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/11c9575fbd4df4b64985f67574d5ddbc455843a9317cb9baabc8c6a99633b328dc1bf74870de048c185c9fa65a61f1d34076374d091aee82d3d319ea1400c2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/200b0ffb77b6152da422a68b24c601754744bf1b5166d95a6555d9113c90b72c10be888933e6c8ea3ab4bbf96036341fa4d193426222b90ffd487c1ee408ae2b"} 11:21:48 INFO - Running post-run listener: copy_logs_to_upload_dir 11:21:48 INFO - Copying logs to upload dir... 11:21:48 INFO - mkdir: /builds/slave/test/build/upload/logs 11:21:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.660260 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-29 11:21:48.542778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:21:48.546481) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221 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/Larch-Non-PGO/sha512/11c9575fbd4df4b64985f67574d5ddbc455843a9317cb9baabc8c6a99633b328dc1bf74870de048c185c9fa65a61f1d34076374d091aee82d3d319ea1400c2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/200b0ffb77b6152da422a68b24c601754744bf1b5166d95a6555d9113c90b72c10be888933e6c8ea3ab4bbf96036341fa4d193426222b90ffd487c1ee408ae2b"} build_url:https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/11c9575fbd4df4b64985f67574d5ddbc455843a9317cb9baabc8c6a99633b328dc1bf74870de048c185c9fa65a61f1d34076374d091aee82d3d319ea1400c2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/200b0ffb77b6152da422a68b24c601754744bf1b5166d95a6555d9113c90b72c10be888933e6c8ea3ab4bbf96036341fa4d193426222b90ffd487c1ee408ae2b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:21:48.575985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:21:48.576340) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467223272.221452-1724294221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:21:48.660679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:21:48.661021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:21:48.661352) ========= ========= Total master_lag: 0.19 =========