builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1460586373.3 results: success (0) buildid: 20160413140844 builduid: 466ecd54197143ca91a6589baba533ac revision: 196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.297868) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.298335) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.298989) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.323045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.323374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.337523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.337963) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.388694) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.388964) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.389334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.389612) ========= 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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 15:26: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.8M=0.001s 2016-04-13 15:26:13 (22.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163719 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.567163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.567452) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016334 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:13.617508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 15:26:13.617825) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd --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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 15:26:13,686 truncating revision to first 12 chars 2016-04-13 15:26:13,687 Setting DEBUG logging. 2016-04-13 15:26:13,687 attempt 1/10 2016-04-13 15:26:13,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/196a0e282b3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 15:26:14,841 unpacking tar archive at: mozilla-central-196a0e282b3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 15:26:15.062784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:15.063124) ========= echo 196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd'] 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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd program finished with exit code 0 elapsedTime=0.003604 script_repo_revision: '196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:15.111337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:15.111656) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 15:26:15.122126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-13 15:26:15.122502) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:26:15 INFO - MultiFileLogger online at 20160413 15:26:15 in /builds/slave/test 15:26:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:26:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:15 INFO - {'append_to_log': False, 15:26:15 INFO - 'base_work_dir': '/builds/slave/test', 15:26:15 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:26:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:15 INFO - 'branch': 'Firefox-Non-PGO', 15:26:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:15 INFO - 'config_files': ('talos/linux_config.py',), 15:26:15 INFO - 'default_actions': ('clobber', 15:26:15 INFO - 'read-buildbot-config', 15:26:15 INFO - 'download-and-extract', 15:26:15 INFO - 'populate-webroot', 15:26:15 INFO - 'create-virtualenv', 15:26:15 INFO - 'install', 15:26:15 INFO - 'run-tests'), 15:26:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:15 INFO - 'download_minidump_stackwalk': True, 15:26:15 INFO - 'download_symbols': 'ondemand', 15:26:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:15 INFO - 'installer_path': 'installer.exe', 15:26:15 INFO - 'log_level': 'info', 15:26:15 INFO - 'log_name': 'talos', 15:26:15 INFO - 'log_to_console': True, 15:26:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:26:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:26:15 INFO - 'opt_config_files': (), 15:26:15 INFO - 'pip_index': False, 15:26:15 INFO - 'sps_profile': False, 15:26:15 INFO - 'sps_profile_interval': 0, 15:26:15 INFO - 'suite': 'dromaeojs-e10s', 15:26:15 INFO - 'system_bits': '32', 15:26:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:15 INFO - 'title': 'talos-linux64-ix-044', 15:26:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:15 INFO - 'use_talos_json': True, 15:26:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:15 INFO - 'work_dir': 'build'} 15:26:15 INFO - ##### 15:26:15 INFO - ##### Running clobber step. 15:26:15 INFO - ##### 15:26:15 INFO - Running pre-action listener: _resource_record_pre_action 15:26:15 INFO - Running main action method: clobber 15:26:15 INFO - rmtree: /builds/slave/test/build 15:26:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:15 INFO - Running post-action listener: _resource_record_post_action 15:26:15 INFO - ##### 15:26:15 INFO - ##### Running read-buildbot-config step. 15:26:15 INFO - ##### 15:26:15 INFO - Running pre-action listener: _resource_record_pre_action 15:26:15 INFO - Running main action method: read_buildbot_config 15:26:15 INFO - Using buildbot properties: 15:26:15 INFO - { 15:26:15 INFO - "project": "", 15:26:15 INFO - "product": "firefox", 15:26:15 INFO - "script_repo_revision": "production", 15:26:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:26:15 INFO - "repository": "", 15:26:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:26:15 INFO - "buildid": "20160413140844", 15:26:15 INFO - "pgo_build": "False", 15:26:15 INFO - "basedir": "/builds/slave/test", 15:26:15 INFO - "buildnumber": 320, 15:26:15 INFO - "slavename": "talos-linux64-ix-044", 15:26:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:26:15 INFO - "platform": "ubuntu64_hw", 15:26:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:26:15 INFO - "branch": "mozilla-central", 15:26:15 INFO - "repo_path": "mozilla-central", 15:26:15 INFO - "revision": "196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd", 15:26:15 INFO - "stage_platform": "linux64", 15:26:15 INFO - "builduid": "466ecd54197143ca91a6589baba533ac", 15:26:15 INFO - "slavebuilddir": "test" 15:26:15 INFO - } 15:26:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:26:15 INFO - Running post-action listener: _resource_record_post_action 15:26:15 INFO - ##### 15:26:15 INFO - ##### Running download-and-extract step. 15:26:15 INFO - ##### 15:26:15 INFO - Running pre-action listener: _resource_record_pre_action 15:26:15 INFO - Running main action method: download_and_extract 15:26:15 INFO - mkdir: /builds/slave/test/build/tests 15:26: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')]} 15:26:15 INFO - https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:26:23 INFO - Downloaded 1361 bytes. 15:26:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:26:23 INFO - Using the following test package requirements: 15:26:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:26:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:26:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:23 INFO - u'jsshell-linux-x86_64.zip'], 15:26:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:26:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:26:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:26:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:26:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:26:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:26: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')]} 15:26:23 INFO - https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:26:31 INFO - Downloaded 22198810 bytes. 15:26:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:26:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:26:32 INFO - Return code: 0 15:26:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:32 INFO - https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:26:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:26:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:26:33 INFO - Downloaded 22198810 bytes. 15:26:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:26:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:26:34 INFO - Return code: 0 15:26:34 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')]} 15:26:34 INFO - https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:26:36 INFO - Downloaded 10841076 bytes. 15:26:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:26:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:26:36 INFO - Return code: 0 15:26: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')]} 15:26:36 INFO - https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:26:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:26:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:26:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:26:37 INFO - Downloaded 54160623 bytes. 15:26:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:26:37 INFO - mkdir: /builds/slave/test/properties 15:26:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:37 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:37 INFO - Contents: 15:26:37 INFO - build_url:https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:26:38 INFO - Running post-action listener: _resource_record_post_action 15:26:38 INFO - Running post-action listener: set_extra_try_arguments 15:26:38 INFO - ##### 15:26:38 INFO - ##### Running populate-webroot step. 15:26:38 INFO - ##### 15:26:38 INFO - Running pre-action listener: _resource_record_pre_action 15:26:38 INFO - Running main action method: populate_webroot 15:26:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:38 INFO - '--tppagecycles', 15:26:38 INFO - '7'], 15:26:38 INFO - 'tests': ['tsvgm']}}, 15:26:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:26:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:26:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:38 INFO - 'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:38 INFO - 'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['damp', 'tps']}, 15:26:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:38 INFO - 'tests': ['damp', 'tps']}, 15:26:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['dromaeo_dom']}, 15:26:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['a11yr', 15:26:38 INFO - 'ts_paint', 15:26:38 INFO - 'tpaint', 15:26:38 INFO - 'sessionrestore', 15:26:38 INFO - 'sessionrestore_no_auto_restore', 15:26:38 INFO - 'tabpaint']}, 15:26:38 INFO - 'other-e10s': {'tests': ['a11yr', 15:26:38 INFO - 'ts_paint', 15:26:38 INFO - 'tpaint', 15:26:38 INFO - 'sessionrestore', 15:26:38 INFO - 'sessionrestore_no_auto_restore', 15:26:38 INFO - 'tabpaint']}, 15:26:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:26:38 INFO - 'ts_paint', 15:26:38 INFO - 'tpaint', 15:26:38 INFO - 'sessionrestore', 15:26:38 INFO - 'sessionrestore_no_auto_restore', 15:26:38 INFO - 'tabpaint']}, 15:26:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:26:38 INFO - 'ts_paint', 15:26:38 INFO - 'tpaint', 15:26:38 INFO - 'sessionrestore', 15:26:38 INFO - 'sessionrestore_no_auto_restore', 15:26:38 INFO - 'tabpaint']}, 15:26:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['a11yr', 15:26:38 INFO - 'ts_paint', 15:26:38 INFO - 'tpaint', 15:26:38 INFO - 'sessionrestore', 15:26:38 INFO - 'sessionrestore_no_auto_restore', 15:26:38 INFO - 'tabpaint']}, 15:26:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['a11yr', 15:26:38 INFO - 'ts_paint', 15:26:38 INFO - 'tpaint', 15:26:38 INFO - 'sessionrestore', 15:26:38 INFO - 'sessionrestore_no_auto_restore', 15:26:38 INFO - 'tabpaint']}, 15:26:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['tsvgx', 15:26:38 INFO - 'tsvgr_opacity', 15:26:38 INFO - 'tart', 15:26:38 INFO - 'tscrollx', 15:26:38 INFO - 'cart']}, 15:26:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:26:38 INFO - 'tsvgr_opacity', 15:26:38 INFO - 'tart', 15:26:38 INFO - 'tscrollx', 15:26:38 INFO - 'cart']}, 15:26:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:38 INFO - 'talos_options': ['--disable-e10s'], 15:26:38 INFO - 'tests': ['tp5o']}, 15:26:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:38 INFO - 'tests': ['tp5o']}, 15:26:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:38 INFO - 'talos_options': ['--disable-e10s', 15:26:38 INFO - '--xperf_path', 15:26:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:38 INFO - 'tests': ['tp5n']}, 15:26:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:38 INFO - 'talos_options': ['--xperf_path', 15:26:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:38 INFO - 'tests': ['tp5n']}}, 15:26:38 INFO - 'talos.zip': {'path': '', 15:26:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:38 INFO - Running post-action listener: _resource_record_post_action 15:26:38 INFO - ##### 15:26:38 INFO - ##### Running create-virtualenv step. 15:26:38 INFO - ##### 15:26:38 INFO - Running pre-action listener: _resource_record_pre_action 15:26:38 INFO - Running main action method: create_virtualenv 15:26:38 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:38 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 15:26:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:38 INFO - Using real prefix '/usr' 15:26:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:38 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:40 INFO - Installing pip.................done. 15:26:40 INFO - Return code: 0 15:26:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:40 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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:26:40 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 15:26:40 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 15:26:40 INFO - Using env: {'DISPLAY': ':0', 15:26:40 INFO - 'HOME': '/home/cltbld', 15:26:40 INFO - 'LANG': 'en_US.UTF-8', 15:26:40 INFO - 'LANGUAGE': 'en_US:en', 15:26:40 INFO - 'LOGNAME': 'cltbld', 15:26:40 INFO - 'MAIL': '/var/mail/cltbld', 15:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:40 INFO - 'MOZ_NO_REMOTE': '1', 15:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:40 INFO - 'NO_EM_RESTART': '1', 15:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:40 INFO - 'PWD': '/builds/slave/test', 15:26:40 INFO - 'SHELL': '/bin/bash', 15:26:40 INFO - 'SHLVL': '1', 15:26:40 INFO - 'TERM': 'linux', 15:26:40 INFO - 'TMOUT': '86400', 15:26:40 INFO - 'USER': 'cltbld', 15:26:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:40 INFO - '_': '/tools/buildbot/bin/python'} 15:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:41 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 15:26:41 INFO - Cleaning up... 15:26:41 INFO - Return code: 0 15:26:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:41 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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:26:41 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 15:26:41 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 15:26:41 INFO - Using env: {'DISPLAY': ':0', 15:26:41 INFO - 'HOME': '/home/cltbld', 15:26:41 INFO - 'LANG': 'en_US.UTF-8', 15:26:41 INFO - 'LANGUAGE': 'en_US:en', 15:26:41 INFO - 'LOGNAME': 'cltbld', 15:26:41 INFO - 'MAIL': '/var/mail/cltbld', 15:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:41 INFO - 'MOZ_NO_REMOTE': '1', 15:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:41 INFO - 'NO_EM_RESTART': '1', 15:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:41 INFO - 'PWD': '/builds/slave/test', 15:26:41 INFO - 'SHELL': '/bin/bash', 15:26:41 INFO - 'SHLVL': '1', 15:26:41 INFO - 'TERM': 'linux', 15:26:41 INFO - 'TMOUT': '86400', 15:26:41 INFO - 'USER': 'cltbld', 15:26:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:41 INFO - '_': '/tools/buildbot/bin/python'} 15:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:41 INFO - Downloading/unpacking psutil>=0.7.1 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:26:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:43 INFO - Installing collected packages: psutil 15:26:43 INFO - Running setup.py install for psutil 15:26:43 INFO - building 'psutil._psutil_linux' extension 15:26:43 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 15:26:43 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 15:26:43 INFO - building 'psutil._psutil_posix' extension 15:26:43 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 15:26:43 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 15:26:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:43 INFO - Successfully installed psutil 15:26:43 INFO - Cleaning up... 15:26:44 INFO - Return code: 0 15:26:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:26:44 INFO - Using env: {'DISPLAY': ':0', 15:26:44 INFO - 'HOME': '/home/cltbld', 15:26:44 INFO - 'LANG': 'en_US.UTF-8', 15:26:44 INFO - 'LANGUAGE': 'en_US:en', 15:26:44 INFO - 'LOGNAME': 'cltbld', 15:26:44 INFO - 'MAIL': '/var/mail/cltbld', 15:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:44 INFO - 'MOZ_NO_REMOTE': '1', 15:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:44 INFO - 'NO_EM_RESTART': '1', 15:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:44 INFO - 'PWD': '/builds/slave/test', 15:26:44 INFO - 'SHELL': '/bin/bash', 15:26:44 INFO - 'SHLVL': '1', 15:26:44 INFO - 'TERM': 'linux', 15:26:44 INFO - 'TMOUT': '86400', 15:26:44 INFO - 'USER': 'cltbld', 15:26:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:44 INFO - '_': '/tools/buildbot/bin/python'} 15:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:26:46 INFO - Installing collected packages: mozsystemmonitor 15:26:46 INFO - Running setup.py install for mozsystemmonitor 15:26:46 INFO - Successfully installed mozsystemmonitor 15:26:46 INFO - Cleaning up... 15:26:46 INFO - Return code: 0 15:26:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:46 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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:26:46 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 15:26:46 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 15:26:46 INFO - Using env: {'DISPLAY': ':0', 15:26:46 INFO - 'HOME': '/home/cltbld', 15:26:46 INFO - 'LANG': 'en_US.UTF-8', 15:26:46 INFO - 'LANGUAGE': 'en_US:en', 15:26:46 INFO - 'LOGNAME': 'cltbld', 15:26:46 INFO - 'MAIL': '/var/mail/cltbld', 15:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:46 INFO - 'MOZ_NO_REMOTE': '1', 15:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:46 INFO - 'NO_EM_RESTART': '1', 15:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:46 INFO - 'PWD': '/builds/slave/test', 15:26:46 INFO - 'SHELL': '/bin/bash', 15:26:46 INFO - 'SHLVL': '1', 15:26:46 INFO - 'TERM': 'linux', 15:26:46 INFO - 'TMOUT': '86400', 15:26:46 INFO - 'USER': 'cltbld', 15:26:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:46 INFO - '_': '/tools/buildbot/bin/python'} 15:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:26:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:26:48 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 15:26:48 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 15:26:48 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 15:26:48 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 15:26:48 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 15:26:48 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 15:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:26:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:49 INFO - Downloading docopt-0.6.1.tar.gz 15:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:26:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:26:49 INFO - Running setup.py install for blobuploader 15:26:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:26:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:26:49 INFO - Running setup.py install for requests 15:26:50 INFO - Running setup.py install for docopt 15:26:50 INFO - Successfully installed blobuploader requests docopt 15:26:50 INFO - Cleaning up... 15:26:50 INFO - Return code: 0 15:26:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:50 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')]} 15:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:50 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')]} 15:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:50 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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:26:50 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 15:26:50 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 15:26:50 INFO - Using env: {'DISPLAY': ':0', 15:26:50 INFO - 'HOME': '/home/cltbld', 15:26:50 INFO - 'LANG': 'en_US.UTF-8', 15:26:50 INFO - 'LANGUAGE': 'en_US:en', 15:26:50 INFO - 'LOGNAME': 'cltbld', 15:26:50 INFO - 'MAIL': '/var/mail/cltbld', 15:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:50 INFO - 'MOZ_NO_REMOTE': '1', 15:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:50 INFO - 'NO_EM_RESTART': '1', 15:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:50 INFO - 'PWD': '/builds/slave/test', 15:26:50 INFO - 'SHELL': '/bin/bash', 15:26:50 INFO - 'SHLVL': '1', 15:26:50 INFO - 'TERM': 'linux', 15:26:50 INFO - 'TMOUT': '86400', 15:26:50 INFO - 'USER': 'cltbld', 15:26:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:50 INFO - '_': '/tools/buildbot/bin/python'} 15:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:26:50 INFO - Running setup.py (path:/tmp/pip-XEmNrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:26:50 INFO - Running setup.py (path:/tmp/pip-czMiEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:26:50 INFO - Running setup.py (path:/tmp/pip-YcVeF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:26:50 INFO - Running setup.py (path:/tmp/pip-FeFlb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:26:50 INFO - Running setup.py (path:/tmp/pip-_w7jC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:26:50 INFO - Running setup.py (path:/tmp/pip-NedeI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:26:50 INFO - Running setup.py (path:/tmp/pip-JOxZtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:26:50 INFO - Running setup.py (path:/tmp/pip-xJ_wfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:26:51 INFO - Running setup.py (path:/tmp/pip-jXdPXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:26:51 INFO - Running setup.py (path:/tmp/pip-VVaI9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:26:51 INFO - Running setup.py (path:/tmp/pip-71XR3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:26:51 INFO - Running setup.py (path:/tmp/pip-zevNAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:26:51 INFO - Running setup.py (path:/tmp/pip-f_qBO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:26:51 INFO - Running setup.py (path:/tmp/pip-elqLIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:51 INFO - Running setup.py (path:/tmp/pip-W6zzaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:26:51 INFO - Running setup.py (path:/tmp/pip-EmBmOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:26:51 INFO - Running setup.py (path:/tmp/pip-lrflxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:26:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:26:51 INFO - Running setup.py install for manifestparser 15:26:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:26:51 INFO - Running setup.py install for mozcrash 15:26:51 INFO - Running setup.py install for mozdebug 15:26:51 INFO - Running setup.py install for mozdevice 15:26:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Running setup.py install for mozfile 15:26:52 INFO - Running setup.py install for mozhttpd 15:26:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Running setup.py install for mozinfo 15:26:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Running setup.py install for mozInstall 15:26:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Running setup.py install for mozleak 15:26:52 INFO - Running setup.py install for mozlog 15:26:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Running setup.py install for moznetwork 15:26:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:26:52 INFO - Running setup.py install for mozprocess 15:26:52 INFO - Running setup.py install for mozprofile 15:26:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:26:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:26:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:26:53 INFO - Running setup.py install for mozrunner 15:26:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:26:53 INFO - Running setup.py install for mozscreenshot 15:26:53 INFO - Running setup.py install for moztest 15:26:53 INFO - Running setup.py install for mozversion 15:26:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:26:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:26:53 INFO - Cleaning up... 15:26:53 INFO - Return code: 0 15:26:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:53 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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:26:53 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 15:26:53 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 15:26:53 INFO - Using env: {'DISPLAY': ':0', 15:26:53 INFO - 'HOME': '/home/cltbld', 15:26:53 INFO - 'LANG': 'en_US.UTF-8', 15:26:53 INFO - 'LANGUAGE': 'en_US:en', 15:26:53 INFO - 'LOGNAME': 'cltbld', 15:26:53 INFO - 'MAIL': '/var/mail/cltbld', 15:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:53 INFO - 'MOZ_NO_REMOTE': '1', 15:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:53 INFO - 'NO_EM_RESTART': '1', 15:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:53 INFO - 'PWD': '/builds/slave/test', 15:26:53 INFO - 'SHELL': '/bin/bash', 15:26:53 INFO - 'SHLVL': '1', 15:26:53 INFO - 'TERM': 'linux', 15:26:53 INFO - 'TMOUT': '86400', 15:26:53 INFO - 'USER': 'cltbld', 15:26:53 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:53 INFO - '_': '/tools/buildbot/bin/python'} 15:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:26:53 INFO - Running setup.py (path:/tmp/pip-YY6PbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:26:53 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)) 15:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:26:53 INFO - Running setup.py (path:/tmp/pip-m4Tth0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:26:53 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)) 15:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:26:53 INFO - Running setup.py (path:/tmp/pip-pVGHAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:26:53 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)) 15:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:26:53 INFO - Running setup.py (path:/tmp/pip-OnQNG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:26:53 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)) 15:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:26:53 INFO - Running setup.py (path:/tmp/pip-dj5xR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:26:54 INFO - Running setup.py (path:/tmp/pip-P0U0Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:26:54 INFO - Running setup.py (path:/tmp/pip-PB8il3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:26:54 INFO - Running setup.py (path:/tmp/pip-DNbLsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:26:54 INFO - Running setup.py (path:/tmp/pip-DB3Wxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:26:54 INFO - Running setup.py (path:/tmp/pip-DW0EhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:26:54 INFO - Running setup.py (path:/tmp/pip-TiIgPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:26:54 INFO - Running setup.py (path:/tmp/pip-w3JUGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:26:54 INFO - Running setup.py (path:/tmp/pip-caal_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:26:54 INFO - Running setup.py (path:/tmp/pip-aIlmwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:54 INFO - Running setup.py (path:/tmp/pip-QnqQkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:26:54 INFO - Running setup.py (path:/tmp/pip-zofS3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:26:54 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)) 15:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:26:54 INFO - Running setup.py (path:/tmp/pip-uvMRyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:26:54 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)) 15:26:54 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)) 15:26:54 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)) 15:26:54 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)) 15:26:54 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)) 15:26:54 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)) 15:26:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:56 INFO - Downloading blessings-1.6.tar.gz 15:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:26:56 INFO - Installing collected packages: blessings 15:26:56 INFO - Running setup.py install for blessings 15:26:56 INFO - Successfully installed blessings 15:26:56 INFO - Cleaning up... 15:26:57 INFO - Return code: 0 15:26:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:26:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:26:57 INFO - Reading from file tmpfile_stdout 15:26:57 INFO - Current package versions: 15:26:57 INFO - argparse == 1.2.1 15:26:57 INFO - blessings == 1.6 15:26:57 INFO - blobuploader == 1.2.4 15:26:57 INFO - docopt == 0.6.1 15:26:57 INFO - manifestparser == 1.1 15:26:57 INFO - mozInstall == 1.12 15:26:57 INFO - mozcrash == 0.17 15:26:57 INFO - mozdebug == 0.1 15:26:57 INFO - mozdevice == 0.48 15:26:57 INFO - mozfile == 1.2 15:26:57 INFO - mozhttpd == 0.7 15:26:57 INFO - mozinfo == 0.9 15:26:57 INFO - mozleak == 0.1 15:26:57 INFO - mozlog == 3.1 15:26:57 INFO - moznetwork == 0.27 15:26:57 INFO - mozprocess == 0.22 15:26:57 INFO - mozprofile == 0.28 15:26:57 INFO - mozrunner == 6.11 15:26:57 INFO - mozscreenshot == 0.1 15:26:57 INFO - mozsystemmonitor == 0.0 15:26:57 INFO - moztest == 0.7 15:26:57 INFO - mozversion == 1.4 15:26:57 INFO - psutil == 3.1.1 15:26:57 INFO - requests == 1.2.3 15:26:57 INFO - wsgiref == 0.1.2 15:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:57 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')]} 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 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')]} 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:26:57 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 15:26:57 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 15:26:57 INFO - Using env: {'DISPLAY': ':0', 15:26:57 INFO - 'HOME': '/home/cltbld', 15:26:57 INFO - 'LANG': 'en_US.UTF-8', 15:26:57 INFO - 'LANGUAGE': 'en_US:en', 15:26:57 INFO - 'LOGNAME': 'cltbld', 15:26:57 INFO - 'MAIL': '/var/mail/cltbld', 15:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:57 INFO - 'MOZ_NO_REMOTE': '1', 15:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:57 INFO - 'NO_EM_RESTART': '1', 15:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:57 INFO - 'PWD': '/builds/slave/test', 15:26:57 INFO - 'SHELL': '/bin/bash', 15:26:57 INFO - 'SHLVL': '1', 15:26:57 INFO - 'TERM': 'linux', 15:26:57 INFO - 'TMOUT': '86400', 15:26:57 INFO - 'USER': 'cltbld', 15:26:57 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:57 INFO - '_': '/tools/buildbot/bin/python'} 15:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 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)) 15:26:57 INFO - Cleaning up... 15:26:57 INFO - Return code: 0 15:26:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:26:57 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')]} 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 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')]} 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:26:57 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 15:26:57 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 15:26:57 INFO - Using env: {'DISPLAY': ':0', 15:26:57 INFO - 'HOME': '/home/cltbld', 15:26:57 INFO - 'LANG': 'en_US.UTF-8', 15:26:57 INFO - 'LANGUAGE': 'en_US:en', 15:26:57 INFO - 'LOGNAME': 'cltbld', 15:26:57 INFO - 'MAIL': '/var/mail/cltbld', 15:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:57 INFO - 'MOZ_NO_REMOTE': '1', 15:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:57 INFO - 'NO_EM_RESTART': '1', 15:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:57 INFO - 'PWD': '/builds/slave/test', 15:26:57 INFO - 'SHELL': '/bin/bash', 15:26:57 INFO - 'SHLVL': '1', 15:26:57 INFO - 'TERM': 'linux', 15:26:57 INFO - 'TMOUT': '86400', 15:26:57 INFO - 'USER': 'cltbld', 15:26:57 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:57 INFO - '_': '/tools/buildbot/bin/python'} 15:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:57 INFO - Downloading/unpacking jsonschema 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:26:59 INFO - Downloading/unpacking functools32 (from jsonschema) 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 INFO - Downloading functools32-3.2.3-2.tar.gz 15:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:26:59 INFO - warning: no files found matching '*.txt' 15:26:59 INFO - no previously-included directories found matching 'build' 15:26:59 INFO - no previously-included directories found matching 'dist' 15:26:59 INFO - no previously-included directories found matching '.git*' 15:26:59 INFO - Installing collected packages: jsonschema, functools32 15:26:59 INFO - Running setup.py install for functools32 15:26:59 INFO - warning: no files found matching '*.txt' 15:26:59 INFO - no previously-included directories found matching 'build' 15:26:59 INFO - no previously-included directories found matching 'dist' 15:26:59 INFO - no previously-included directories found matching '.git*' 15:26:59 INFO - Successfully installed jsonschema functools32 15:26:59 INFO - Cleaning up... 15:26:59 INFO - Return code: 0 15:26:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:26:59 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')]} 15:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:00 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')]} 15:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:00 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 0x7f512981cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe6a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', '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 15:27:00 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 15:27:00 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 15:27:00 INFO - Using env: {'DISPLAY': ':0', 15:27:00 INFO - 'HOME': '/home/cltbld', 15:27:00 INFO - 'LANG': 'en_US.UTF-8', 15:27:00 INFO - 'LANGUAGE': 'en_US:en', 15:27:00 INFO - 'LOGNAME': 'cltbld', 15:27:00 INFO - 'MAIL': '/var/mail/cltbld', 15:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:00 INFO - 'MOZ_NO_REMOTE': '1', 15:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:00 INFO - 'NO_EM_RESTART': '1', 15:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:00 INFO - 'PWD': '/builds/slave/test', 15:27:00 INFO - 'SHELL': '/bin/bash', 15:27:00 INFO - 'SHLVL': '1', 15:27:00 INFO - 'TERM': 'linux', 15:27:00 INFO - 'TMOUT': '86400', 15:27:00 INFO - 'USER': 'cltbld', 15:27:00 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:00 INFO - '_': '/tools/buildbot/bin/python'} 15:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:00 INFO - Downloading/unpacking flake8 15:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:27:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:27:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 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 15:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:27:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:02 INFO - no previously-included directories found matching 'docs/_build' 15:27:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:27:03 INFO - Running setup.py install for pep8 15:27:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:03 INFO - no previously-included directories found matching 'docs/_build' 15:27:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:27:03 INFO - Cleaning up... 15:27:03 INFO - Return code: 0 15:27:03 INFO - Running post-action listener: _resource_record_post_action 15:27:03 INFO - Running post-action listener: _start_resource_monitoring 15:27:03 INFO - Starting resource monitoring. 15:27:03 INFO - ##### 15:27:03 INFO - ##### Running install step. 15:27:03 INFO - ##### 15:27:03 INFO - Running pre-action listener: _resource_record_pre_action 15:27:03 INFO - Running main action method: install 15:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:03 INFO - Reading from file tmpfile_stdout 15:27:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:03 INFO - Reading from file tmpfile_stdout 15:27:03 INFO - Output received: 15:27:03 INFO - Usage: mozinstall [options] installer 15:27:03 INFO - Options: 15:27:03 INFO - -h, --help show this help message and exit 15:27:03 INFO - -d DEST, --destination=DEST 15:27:03 INFO - Directory to install application into. [default: 15:27:03 INFO - "/builds/slave/test"] 15:27:03 INFO - --app=APP Application being installed. [default: firefox] 15:27:03 INFO - mkdir: /builds/slave/test/build/application 15:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:27:19 INFO - Reading from file tmpfile_stdout 15:27:19 INFO - Output received: 15:27:19 INFO - /builds/slave/test/build/application/firefox/firefox 15:27:19 INFO - Running post-action listener: _resource_record_post_action 15:27:19 INFO - ##### 15:27:19 INFO - ##### Running run-tests step. 15:27:19 INFO - ##### 15:27:19 INFO - Running pre-action listener: _resource_record_pre_action 15:27:19 INFO - Running main action method: run_tests 15:27:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:19 INFO - Python 2.7.3 15:27:19 INFO - Return code: 0 15:27:19 INFO - grabbing minidump binary from tooltool 15:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:19 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 0xef9640>, '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 0xefa540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefa9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:19 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 15:27:19 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 15:27:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:19 INFO - Return code: 0 15:27:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:27:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:27:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:27:20 INFO - Return code: 0 15:27:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 15:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 15:27:20 INFO - Using env: {'DISPLAY': ':0', 15:27:20 INFO - 'HOME': '/home/cltbld', 15:27:20 INFO - 'LANG': 'en_US.UTF-8', 15:27:20 INFO - 'LANGUAGE': 'en_US:en', 15:27:20 INFO - 'LOGNAME': 'cltbld', 15:27:20 INFO - 'MAIL': '/var/mail/cltbld', 15:27:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:20 INFO - 'MOZ_NO_REMOTE': '1', 15:27:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:20 INFO - 'NO_EM_RESTART': '1', 15:27:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:20 INFO - 'PWD': '/builds/slave/test', 15:27:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:20 INFO - 'SHELL': '/bin/bash', 15:27:20 INFO - 'SHLVL': '1', 15:27:20 INFO - 'TERM': 'linux', 15:27:20 INFO - 'TMOUT': '86400', 15:27:20 INFO - 'USER': 'cltbld', 15:27:20 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255', 15:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:20 INFO - '_': '/tools/buildbot/bin/python'} 15:27:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 15:27:20 INFO - mozversion application_buildid: 20160413140844 15:27:20 INFO - mozversion application_changeset: 196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd 15:27:20 INFO - mozversion application_display_name: Nightly 15:27:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:20 INFO - mozversion application_name: Firefox 15:27:20 INFO - mozversion application_remotingname: firefox 15:27:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:27:20 INFO - mozversion application_vendor: Mozilla 15:27:20 INFO - mozversion application_version: 48.0a1 15:27:20 INFO - mozversion platform_buildid: 20160413140844 15:27:20 INFO - mozversion platform_changeset: 196a0e282b3e33aa3d82ae6f3e7d21390d2a60fd 15:27:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:27:20 INFO - mozversion platform_version: 48.0a1 15:27:20 INFO - using testdate: 1460586440 15:27:20 INFO - actual date: 1460586440 15:27:20 INFO - starting webserver on 'localhost:56770' 15:27:20 INFO - SUITE-START | Running 2 tests 15:27:20 INFO - TEST-START | dromaeo_css 15:27:20 INFO - operating with platform_type : linux_ 15:27:20 INFO - Initialising browser for dromaeo_css test... 15:27:20 INFO - TEST-INFO | started process 4044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHfZHQa/profile http://localhost:56770/getInfo.html) 15:27:24 INFO - PROCESS | 4044 | 15:27:24 INFO - PROCESS | 4044 | (process:4113): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:27:24 INFO - PROCESS | 4044 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:27:25 INFO - PROCESS | 4044 | __metrics Screen width/height:1600/1200 15:27:25 INFO - PROCESS | 4044 | colorDepth:24 15:27:25 INFO - PROCESS | 4044 | Browser inner width/height: 1024/697 15:27:25 INFO - PROCESS | 4044 | __metrics 15:27:25 ERROR - PROCESS | 4044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:27:26 INFO - TEST-INFO | 4044: exit 0 15:27:26 INFO - Browser initialized. 15:27:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:26 INFO - TEST-INFO | started process 4164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHfZHQa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:28 INFO - PROCESS | 4164 | 15:27:28 INFO - PROCESS | 4164 | (process:4223): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:27:38 INFO - PROCESS | 4164 | RSS: Main: 164126720 15:27:38 INFO - PROCESS | 4164 | 15:28:28 INFO - PROCESS | 4164 | 1460586508325 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] 15:30:40 INFO - PROCESS | 4164 | Cycle 1(1): loaded http://localhost:56770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56770/tests/dromaeo/cssquery-ext.html) 15:30:41 INFO - PROCESS | 4164 | RSS: Main: 169013248 15:30:41 INFO - PROCESS | 4164 | 15:33:43 INFO - PROCESS | 4164 | Cycle 1(1): loaded http://localhost:56770/tests/dromaeo/cssquery-ext.html (next: http://localhost:56770/tests/dromaeo/cssquery-jquery.html) 15:33:44 INFO - PROCESS | 4164 | RSS: Main: 165806080 15:33:44 INFO - PROCESS | 4164 | 15:36:45 INFO - PROCESS | 4164 | Cycle 1(1): loaded http://localhost:56770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56770/tests/dromaeo/cssquery-mootools.html) 15:36:46 INFO - PROCESS | 4164 | RSS: Main: 166133760 15:36:46 INFO - PROCESS | 4164 | 15:39:48 INFO - PROCESS | 4164 | Cycle 1(1): loaded http://localhost:56770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56770/tests/dromaeo/cssquery-prototype.html) 15:39:48 INFO - PROCESS | 4164 | RSS: Main: 163987456 15:39:48 INFO - PROCESS | 4164 | 15:42:51 INFO - PROCESS | 4164 | Cycle 1(1): loaded http://localhost:56770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56770/tests/dromaeo/cssquery-yui.html) 15:42:52 INFO - PROCESS | 4164 | RSS: Main: 165277696 15:42:52 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | Cycle 1(1): loaded http://localhost:56770/tests/dromaeo/cssquery-yui.html (next: http://localhost:56770/tests/dromaeo/cssquery-dojo.html) 15:45:54 INFO - PROCESS | 4164 | RSS: Main: 167149568 15:45:54 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | __start_tp_report 15:45:54 INFO - PROCESS | 4164 | _x_x_mozilla_page_load 15:45:54 INFO - PROCESS | 4164 | _x_x_mozilla_page_load_details 15:45:54 INFO - PROCESS | 4164 | |i|pagename|runs| 15:45:54 INFO - PROCESS | 4164 | |0;dojo.html;2611.3471632091973;2635.4860802143585;2663.934426229508;2666.2267942296735;2677.5715885458317;4648;4689.296605509176;4725.45657249416;4729.148753224418;4792.90414191716;4590.989982203918;4711.740854253015;4720.079584481027;4722.858314250578;4734.976325118379;4252.3834044063515;4313.590208930146;4347.630451411634;4374.8906277343;4421.823127074913;4360.389545463638;4377.737335759864;4400.185965596359;4417.42573465449;4459.286514157736;4063.309237429644;4324.027093903878;4340.804663790137;4410.117976404716;4433.113377324548;4295.334223195409;4310.267254566731;4313.245182093121;4322.675799315032;4362.672799540047;4295;4300.419443375135;4306.418633484471;4330.328799036154;4335.718178318431;4457.576530229656;4560.771961401917;4602.769861506911;4629.8148074077;4641.071785642885;5006.2740902569285;5034.823781167642;5067.898642027176;5072.898542029138;5110.66780659256;4987.700737955734;5055;5078.695278283315;5083.6441449098575;5133.897322053575;4739.976300118477;4769.332293478847;4773.236282194902;4815.422149342031;4816.8314109006715;5074.188129899198;5104.744762761847;5117.334746482933;5124.93396988029;5153.716545589954;4880.389951256093;4923.753812309442;4926.45808961014;4963.131451995886;4986.7257300848805;5001.699898006132;5027.245913112989;5056.216286475602;5060.3927528696795;5100.38795344561;4938.950610493849;4945.727984960789;4970.726610036482;4982.7259500727805;4985.127602669519;4866.0511200316305;4961.751912404366;4987.650864439454;5005.649604527648;5032.3961124665275;3839.2321535692413;3873.6320049595242;3911.2959667260166;3912.139329347539;3942.48747662802;3474.913127171841;3494.8776792812637;3496.6852983231634;3513.9648603514147;3533.205028868484;4229.577042295808;4298.548652391516;4318.5033721121845;4380.452443444569;4406.49325327585;4971.552560269593;5013.523715247045;5052.898942021139;5080.364954380702;5120.564751996048;4319.092990471973;4333.891652708708;4337.479502459725;4338.392625032498;4387.670924680661;4392.4289842320295;4469.798859051285;4473.664475164375;4474.440694913136;4515.841945531956;4793.9280910785665;4796.544328288807;4831.227003679394;4847.854564363075;4863.027394521039;4930.063287975273;4953.925691114709;4960.727160006234;4975.278584605139;4995.950040499549;4702.03608260299;4722.952770472251;4741.620670346295;4757.001029783784;4770.403699537558;4971.701697898137;4983.775730092082;4997.9750101249265;5008.223725322581;5039.823606173766;5065.062963351792;5065.620078494054;5082.263071854634;5089.541941225308;5129.948700512947;4773.403324584427;4888.340074090094;4902.264660300983;4928.6057115431395;4945.851624451272;4854.5873600744335;4878.438979517401;4897.706137631753;4908.607311415007;4924.310596516562;4818.879528011687;4828.734419606955;4835.323054772405;4840.273958906051;4883.121038213156;4862.610991120772;4951.777170027285;4983.177775666974;5031.723255220998;5066.189409694432;4710.670253082251;4805.543473370024;4838.056578967067;4840.975795121002;4866.367372241728 15:45:54 INFO - PROCESS | 4164 | |1;ext.html;552.6352607279194;602.7227475361334;606.7087797857029;628.4406877878689;647.9125318082057;34086.31827363454;35184.472232916465;35236;35526;35530.644693553055;36427.63572364276;36761.81619091901;36996;37028.444573331355;37170.8141459293;7502.624868756568;7706.383489320869;7760.534367937942;7760.689572417096;7763.146053934062;7533.773986780406;7706.961465192694;7756.573388463632;7774.766756997271;7795.454318197729;7791.415643826707;7797.727079552217;7831.216878312181;7833.6083195840265;7834.804129896741;7761;7761.728339508147;7772.805679857992;7785.571793551352;7791.883121753178;7701.499402538817;7770.883436748453;7789.922100779033;7806.531608103532;7846.686132554691;31414.685853141404;36858;36868.81565592182;36987.81506092479;37111.628883711084;3008.6479981301477;3045.345250771095;3115.2211947013247;3137.4352616529245;3140.450421176285;24744.25767226986;26150.215493535223;27331.590026149624;27387.589186162222;28094.157175284774;3205.5191721241767;3254.544363789071;3258.885938992124;3336.115929278743;3382.96617033829;185955;186237;188206;188325;188643;33241.501377479355;33420.49869251963;33617.327653446795;33638.831805841306;33681.66318336834;33033.339333213204;33138.17154571155;33202.16994575107;33331.333373332396;33406.66593334084;11586.420678966018;11744.882551174378;11757.235779674294;11833.585824496102;11876.584319548774;10684.679459616224;10779.78440431187;10901.509432075418;10904.127669786398;10910.454477276264;8291.33669306454;8304.750857474286;8338;8375.95812020936;8413.15868413166;3238.2552013037134;3278.4590542560686;3286.983565082159;3329.067860998924;3350.430426827445;861.6553378648465;895.8521843895815;924.6347692661361;929.8837645294338;958.113744786084;27075.593866092026;27577.44845103087;27640.861795690893;27796.444071118465;28181.43637127246;904.5694130701927;975.5756246032998;985.2315194148575;985.7979114281555;1058.25921854702;14285.142891426547;14500.274986250644;14572;14699.853001469848;14707.485238016618;354625;362625;364375;368584;370903;50817.74591127095;52418.21372679413;52424.737876311134;52595.73702131465;52759.736201318745;1240.4418011894504;1250.0562075632838;1285.042643230799;1286.4403984266874;1287.1762072273566;26444.603330949667;27027;27279;27522.587161192998;27942.86028569844;43168.56831431771;44265;44742.3288650677;44757.328640069776;45042.099158017314;316893;322247;323567;323983;324937;26130;26182;26809.597856031785;26899.596506052032;26967.247128936557;44656.10687786291;44660.55339446694;44993.55006449894;45162;45305.50819704948;37820.43269351017;37848;38139;38457.615423846524;38484.42273365846;36523.37621587704;36645.816770915975;37381.25237495289;37413.625863741014;38226.426603601525;29742.702572973994;30787.38425231438;31055.84472077625;34739.13152171216;35200.471992919614;29774.851125744233;32802;36083.63916360803;36739.26521469609;37541.2491750158;24253.51492970166;24375.75624243806;24431.51136977286;24496.265112046665;24744.65947097191 15:45:54 INFO - PROCESS | 4164 | |2;jquery.html;381.92170605025973;382.5027464296415;383.4191200331496;394.1919065914874;403.513765912076;15645.452409165682;16276.860619756622;16431.34274629015;16747.665046699072;16804.74792878108;15593.298301576428;15794.526164215093;16164;16259.674806503863;16414.17929103543;4925.876853078675;5085.949140508603;5142;5149.897002059956;5162.845114646567;3617.5297211362486;5366.785328586851;5695.601307908448;5747.42525747424;5748.19525266463;5503.587230957674;5639.2668953036045;5642.492175704186;5679.858003549903;5696.6866822324755;5732.455416735404;5742;5769.913451298213;5782.219400380936;5784.363719990798;4899.2896030075435;5073.467285934998;5075;5079.314292570492;5082.644214904958;11099.001089901947;11756.706082347924;20410.69383959242;20481.48796280105;20598.27906023282;1946.766388033431;1948.7076938459202;1992.14337834731;1994.1425187169657;2044.3355909329528;8729.519876406795;9283.907160928371;9306.348555601111;9353.812923741556;9391.483468409235;1736.9044702541355;1749.9912500437417;1775.7957834849028;1806.6025474395612;1835.476889086604;69248.6537567314;70413.64793176002;70490.64754676246;70646;71137.64431177863;9873.729042320307;10193.490325483695;10297.588096476056;10358.326708763907;10364.792704145875;14462.710745785236;14519.564413067625;14605.269736513132;14616.123032618078;14696.11823290606;6945.89581156283;6986.825329366807;7026.894596581055;7129.928700712927;7153.92846071543;6512.772052978218;6522.804315870531;6543.1166792483355;6621.205455345293;6645.06969024337;4316.3093904975685;4342.978285108554;4351.26028575143;4366.366876802846;4403.304727679802;1664.9853677050662;1770.929162833498;1877.4649224970817;1888.2635772048911;1935.8935258560914;798.6086817459403;867.3364875869964;898.7797989492616;944.2210176604192;983.6655537117272;15208.695826083416;16157.676846463004;16250.593735156715;16499.340026398808;16576.751348729536;877.4822854515867;896.6458248991612;913.36064754672;914.8947870994788;951.3055469507299;8961.148690874357;9021.32340074497;9054.275657947348;9075.54622268884;9283.303752218475;390922;407094;413768;420431;421568;47036;69906.65046674733;78067;80572;81179;934.8784657994418;944.4003058058045;950.9667161649309;951.1439704266078;957;14186.716265674835;14361.712765744836;14520;14581.986372905296;14697.265136743334;34037.65962340444;34109;34400.65599344075;35095.29809403849;35335.64664353323;48739.756301218265;48888.51111488982;48912.266316006004;49284;49336;7362.4478164136835;7449.627518623939;7561.546307221584;7636.770896873103;7657.69369225247;10622.256442048982;11568.826467603161;11604.76790464169;11606.129540284344;12039.337836419081;8955.462672239686;9202.907970920205;9293.583668246169;9624.37441566296;10041.297109202578;9529.52352382392;9609.519524023632;9879.925215704783;10194.541245643815;10511.369317840954;4869.31829543857;7189.352958233784;9143.817123657622;9834.557444915139;10230.232732545237;7466.775996720107;7512.39900807945;7565.810854728676;7568.394528437601;7720.652570634447;9790.804183916423;9854.507274636382;9944;10090.293679442368;10169.338992965433 15:45:54 INFO - PROCESS | 4164 | |3;mootools.html;1514.1369419430926;1536.3086611025037;1650.3728583138407;1744.7557341972117;1800.5678637127094;6891.896621550681;7458.328750412462;7676.92323076769;7689.307962283387;7748.651310691018;7604.923950760491;7625.771226863189;7709.922900771005;7714.652840622171;7729.884051739228;2255.4474153832334;2283.8515496492673;2288.0275882749847;2292.3466811958597;2304.0438218139534;2188.9781102188936;2219.678146668732;2235.35174799308;2235.6087684655204;2237.2169740590825;2193.8793366364844;2220.1785339424355;2233.798958093771;2248.123231939545;2262.8981695823727;2219.522802597433;2231.787980141884;2234.754177040524;2236.854604450714;2245.719285089364;2223.9110435582556;2224.610693128696;2233.2853486884205;2236.3738153316935;2240.9775902241095;7841.294283514511;7874.133845277015;7925.247101525346;7935.246151615645;7948;4606.700564463299;4745.3593764842;4751.192297309466;4762.047590481918;4777.5222477752295;2936.8678409471627;2986.0295403993787;3005.4740420426556;3014.6533148687963;3043.4978228592254;930.4928813796497;944.1785646487531;946.3706635087658;952.3952290295712;990.5195979949718;10620.57517699291;10641.308314959502;10644.201684873588;10644.733881653021;10703.304285221435;4134.111166099303;4204.13815167896;4348.412964249849;4350.956490435118;4356.346548017823;9067.773305667279;9083.409578377385;9087.09129087086;9108.362414631045;9123.863142052875;4705.882352941204;4708.788104535304;4732.148213321566;4741.525847415231;4746.715197088186;3735.0849041984343;4170.082581831992;4299.161663475655;4320.416743739618;4364.083542456056;3694.5012423322505;3696.5564132304294;3801.923961520754;3812.8856134316015;3813.3707938189887;1193.0694058634278;1198.3522656347523;1199.7900367435664;1205.7709035283267;1208.468273959455;845.5222799118478;861.9051904290523;883.0463099852144;885.2254277507182;900.0234745301291;5516.3380394352935;5519.420460851553;5546.833594992157;5736;5758.424157584208;886.4769785826264;925.0656836595087;930.8976012638605;977.4409816342921;1011.8077565262577;3470.564141499897;3589.33597284498;3709.221063576625;3741.551013878352;3755.0987762936697;9469.810603787886;9765.902340976641;9813.264005199639;9902.158316543175;9950.900490994998;9634.421934683942;9651.372660777028;9742.171915387271;9773.560189791477;9855.35940163887;7325.304096110861;7418.740344087931;7435.814104647319;7453.142888567776;7494.925050749423;5403.83788486346;5418.972905135449;5427.83716488506;5460.91808622863;5590.301212348457;8888.73333799987;9008.594613242289;9013.459192448474;9057.139571740674;9138.497382644018;8419.36854735885;8795.91204087951;8829.60266788009;8929.24101451358;9083.318751093562;5892.234009578728;6559.442447392025;6749.886268765598;6886.48351373639;7054.576725396492;7351.558906465629;7357.0803649543805;7377.741779037708;7379.520331178456;7423.703051877865;6564.770233041821;6678;6757.831054223487;6804.727810887509;6824.2152152503095;6543.378379053982;6563.146790917151;6584.078229047841;6660.300668429745;6670.132882725409;6307;6361.840953976002;6366.904496432465;6368.5860419072615;6408.519361047846;4578.084383123322;4610.838620648261;4679.876829560949;4758.785854636619;4858.92711609319;4649.816323271135;4662.813487460599;4704.811807527661;4706.435227772689;4744.4069491313585 15:45:54 INFO - PROCESS | 4164 | |4;prototype.html;311.82849432811963;319.6723358557478;325.89897131889114;329.46790932643785;329.70491410187884;5091.541761241488;5142.66572672776;5204.323437953066;5284.841454756359;5292.788288468466;5217.113090774568;5218.060749065176;5232.686038837673;5251.505534870935;5258.316418865552;4043.5349934757437;4045.1505183911413;4063.34986402175;4063.4717486726686;4078.1028173801865;3898.629630185128;4028.8187031583648;4067.4712287402745;4070.613291737295;4076.2458945095104;4007.73949693269;4008.238434697398;4015.687058177001;4018.5934922777087;4027.65764909983;4011.097503061817;4019.432421355674;4038.313486707252;4039.1113954930015;4058.1680755445063;3566.928661426757;3571.535700358963;3580.856765729368;3590.676839084495;3593.3711600470074;4764.428268607755;4965.641320372794;4983.152864013126;4986.675866068694;4990.2764099205415;4649.953500464986;4652.185867473178;4654.115718013567;4666.929996050062;4716.38686970695;5465.945340546584;5475.835724928219;5478.863028424321;5496.31296087989;5526.281583394133;3830.157365379612;3921.117748506592;3928.607139286077;3958.8812335629977;3959.0204897551225;5701.144828275792;5753.245260195638;5762.711864406805;5764.682942438164;5793.015187418149;4012.578679238696;4013.5585085640555;4027.6099052033424;4029.133736246721;4031.7580945143386;4006.539247986519;4089.8773036808943;4095.508538975342;4097.815598298083;4118.8352465901025;4676.134915040729;4678.321643361762;4686;4690.132325519789;4693.084848454587;5506.587005974568;5515.586331025109;5534.225208470817;5536.307961504812;5552.416996215339;1337.6923307639297;1400.7828786538103;1443.1269082205324;1449.4564538298139;1451.622578129694;961.927855410847;982.0228872272135;986.2849434160177;992.1120597065731;1001.2190491416707;4737.24204127338;4773.809047638125;4777.474477807438;4779.330893674888;4785.665003449725;5564.33228012641;5607.663540187602;5624.072028115315;5624.493795558337;5643.717814109278;4649.4420669519195;4753.096911586787;4762.357081793983;4765.142274390573;4812.614990800727;2947.292649764041;3009.277773334384;3023.576699262105;3029.409265193266;3029.909102726922;5251.501107394792;5296;5297.576193904479;5300.628955973122;5345.705986170798;5490.203920431595;5697.379205565403;5741.971290143606;5765.423457654201;5771.249737534094;5302.337207849019;5309.522262917718;5320.122179840283;5320.281761962163;5325.147976323769;5494.269305168859;5595.160725891149;5599.60802743804;5617.775288988395;5630.18362337467;5504.4770746778995;5539.9169012464035;5541.556675466034;5542.75057622416;5542.97228513871;5306.177542480922;5315.176147697113;5328.200769884548;5341.332333458317;5346.8395948121615;3778.848846046237;4070.4504891839224;4073.877783666495;4083.734557253769;4091.0386059276643;5445.564354851523;5566.966003528006;5687.914681279702;5689.374168841341;5701.828945131652;5566.944330556643;5570.3315602128005;5577.991922907669;5585.69278689676;5587.5809314302405;5544.944550554443;5546.500814926676;5548.9722551386985;5551.389347171727;5569.665820050648;5261.473852614861;5463.07127788269;5474;5478.753456094565;5503.834884953458;5513.476219759116;5582.441755824385;5595.944040559705;5597.608167428241;5600.523955463668;5290.9735451322495;5402.838389746224;5405.594580406564;5446.891062178814;5475.890482190413 15:45:54 INFO - PROCESS | 4164 | |5;yui.html;694.2571448550051;796.7888509544968;798.680527788884;803.180755629258;808.1030056637131;12170.939145304283;12198.939005304972;12322;12474.064445166603;12491.812622810654;12414.751704965895;12455.377231138453;12504.249745015306;12512.624621261353;12544.874551254485;652.451940370089;811.1239860950175;820.8686610142379;856.6530555125184;857.9099194584572;832.0930186097153;841.2302742990187;848.245061894914;848.3425345357366;849.9532525711084;865.8657908024267;876.6099085906774;884.5842454046619;884.7743825324533;886.4548302793768;866.2506931504266;873.4802792338548;877.3332267476732;884.0584777212248;885.8671199320089;637.8660481298933;639;639.076534407781;642.0657942693416;642.2036674523604;12994.28531430771;13004.349782510932;13007.414666340037;13011.284379359131;13122.737545249041;12649;12748.490060397573;12984.87015129846;13153.802692959613;13339.933300333436;10053.949730251376;10196.643117490852;10262.846057309072;10361.067503924607;10541.156707463384;3318.5851768528933;3350.279689866666;3354.295597924439;3355.798652080883;3367.9494807577908;45734.313985290246;45755.084898301844;45826.31260531062;47315.5268447318;47518.5248147521;10102.444365559817;10159.796804064024;10235.749331844163;10339.896601033894;10455.68632941013;17997.460076197734;18022.819771802377;18124.365647202285;18134.274629014955;18193.45419637413;7044.22513523512;7216.96391518039;7223.097112860893;7226.7109315626785;7281.963590182015;3748.5126933499014;3766.077311058808;3836.712246581518;3840.1551658635058;3908.7459315144424;2892.739653431201;2934.7505462035538;2948.660903996025;2952.0848536953613;2964.021872781977;521.8538809133448;532.2495281652929;534.0973754355127;534.3667753711863;551.0741953518047;581.2501872584319;650.4016304999412;650.4796163069525;661.798151563768;667.6227931218846;8063.758087257392;8083.19168083187;8219.178082191733;8282.627281772335;8326.958365208257;620.5439002333281;623.1742940603718;643.0386572074779;649.8281035750493;656.3928366261189;3902.70729695274;3914.158455931988;3933.704972127102;3940.133170702441;4001.91996160081;54310.72844635751;54770;55317.72341138349;55476.72261638666;55631.721841390536;46163.538364615924;47704;47842.28236576454;47893.5210647889;48614.27078593824;41525.1694966099;42558;42924;42980.570194298285;43327.78336108299;7586.962065189638;7601.885971710318;8053.718119865776;8244;8315.419337140529;26664.20007399781;26837.194884153505;27591.31021724473;27635.723642763314;28561.857190713912;36715.08212294714;38585.22829543337;39503.2099358017;39540.2091958165;39783.80108099557;10497.632582859564;10816.945915270373;10842.566297348018;10843.783124337311;10853.674389768319;11068.169887258327;11110.777784444104;11181.273217240854;11213.102951763676;11282.266652667551;9704.078112579293;10534.420606866695;10890.455477226265;11013.472762888563;11880.10899182582;10708.357498550113;10781.407022613832;10878.184136189975;11078.169137314573;11090.390028548507;10974.561017559208;11002.614908478165;11084.279521831055;11173.217874749014;11239.04468120219;9345.252379809735;9673.903260967581;9678.370905891095;9816.054760423149;9908.752281193028;9559.522023898917;9570.90429095728;9580.520973951136;9592.712218633173;9686.128248457673 15:45:54 INFO - PROCESS | 4164 | __end_tp_report 15:45:54 INFO - PROCESS | 4164 | __start_cc_report 15:45:54 INFO - PROCESS | 4164 | _x_x_mozilla_cycle_collect,367 15:45:54 INFO - PROCESS | 4164 | __end_cc_report 15:45:54 INFO - PROCESS | 4164 | __startTimestamp1460587554933__endTimestamp 15:45:54 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | ------- Summary: start ------- 15:45:54 INFO - PROCESS | 4164 | Number of tests: 6 15:45:54 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | [#0] dojo.html Cycles:165 Average:4633.06 Median:4805.54 stddev:511.75 (10.6%) stddev-sans-first:488.13 15:45:54 INFO - PROCESS | 4164 | Values: 2611.3 2635.5 2663.9 2666.2 2677.6 4648.0 4689.3 4725.5 4729.1 4792.9 4591.0 4711.7 4720.1 4722.9 4735.0 4252.4 4313.6 4347.6 4374.9 4421.8 4360.4 4377.7 4400.2 4417.4 4459.3 4063.3 4324.0 4340.8 4410.1 4433.1 4295.3 4310.3 4313.2 4322.7 4362.7 4295.0 4300.4 4306.4 4330.3 4335.7 4457.6 4560.8 4602.8 4629.8 4641.1 5006.3 5034.8 5067.9 5072.9 5110.7 4987.7 5055.0 5078.7 5083.6 5133.9 4740.0 4769.3 4773.2 4815.4 4816.8 5074.2 5104.7 5117.3 5124.9 5153.7 4880.4 4923.8 4926.5 4963.1 4986.7 5001.7 5027.2 5056.2 5060.4 5100.4 4939.0 4945.7 4970.7 4982.7 4985.1 4866.1 4961.8 4987.7 5005.6 5032.4 3839.2 3873.6 3911.3 3912.1 3942.5 3474.9 3494.9 3496.7 3514.0 3533.2 4229.6 4298.5 4318.5 4380.5 4406.5 4971.6 5013.5 5052.9 5080.4 5120.6 4319.1 4333.9 4337.5 4338.4 4387.7 4392.4 4469.8 4473.7 4474.4 4515.8 4793.9 4796.5 4831.2 4847.9 4863.0 4930.1 4953.9 4960.7 4975.3 4996.0 4702.0 4723.0 4741.6 4757.0 4770.4 4971.7 4983.8 4998.0 5008.2 5039.8 5065.1 5065.6 5082.3 5089.5 5129.9 4773.4 4888.3 4902.3 4928.6 4945.9 4854.6 4878.4 4897.7 4908.6 4924.3 4818.9 4828.7 4835.3 4840.3 4883.1 4862.6 4951.8 4983.2 5031.7 5066.2 4710.7 4805.5 4838.1 4841.0 4866.4 15:45:54 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | [#1] ext.html Cycles:180 Average:43412.82 Median:35218.24 stddev:79491.75 (225.7%) stddev-sans-first:79649.61 15:45:54 INFO - PROCESS | 4164 | Values: 552.6 602.7 606.7 628.4 647.9 34086.3 35184.5 35236.0 35526.0 35530.6 36427.6 36761.8 36996.0 37028.4 37170.8 7502.6 7706.4 7760.5 7760.7 7763.1 7533.8 7707.0 7756.6 7774.8 7795.5 7791.4 7797.7 7831.2 7833.6 7834.8 7761.0 7761.7 7772.8 7785.6 7791.9 7701.5 7770.9 7789.9 7806.5 7846.7 31414.7 36858.0 36868.8 36987.8 37111.6 3008.6 3045.3 3115.2 3137.4 3140.5 24744.3 26150.2 27331.6 27387.6 28094.2 3205.5 3254.5 3258.9 3336.1 3383.0 185955.0 186237.0 188206.0 188325.0 188643.0 33241.5 33420.5 33617.3 33638.8 33681.7 33033.3 33138.2 33202.2 33331.3 33406.7 11586.4 11744.9 11757.2 11833.6 11876.6 10684.7 10779.8 10901.5 10904.1 10910.5 8291.3 8304.8 8338.0 8376.0 8413.2 3238.3 3278.5 3287.0 3329.1 3350.4 861.7 895.9 924.6 929.9 958.1 27075.6 27577.4 27640.9 27796.4 28181.4 904.6 975.6 985.2 985.8 1058.3 14285.1 14500.3 14572.0 14699.9 14707.5 354625.0 362625.0 364375.0 368584.0 370903.0 50817.7 52418.2 52424.7 52595.7 52759.7 1240.4 1250.1 1285.0 1286.4 1287.2 26444.6 27027.0 27279.0 27522.6 27942.9 43168.6 44265.0 44742.3 44757.3 45042.1 316893.0 322247.0 323567.0 323983.0 324937.0 26130.0 26182.0 26809.6 26899.6 26967.2 44656.1 44660.6 44993.6 45162.0 45305.5 37820.4 37848.0 38139.0 38457.6 38484.4 36523.4 36645.8 37381.3 37413.6 38226.4 29742.7 30787.4 31055.8 34739.1 35200.5 29774.9 32802.0 36083.6 36739.3 37541.2 24253.5 24375.8 24431.5 24496.3 24744.7 15:45:54 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | [#2] jquery.html Cycles:180 Average:24354.89 Median:5074.23 stddev:67675.63 (1333.7%) stddev-sans-first:67841.54 15:45:54 INFO - PROCESS | 4164 | Values: 381.9 382.5 383.4 394.2 403.5 15645.5 16276.9 16431.3 16747.7 16804.7 15593.3 15794.5 16164.0 16259.7 16414.2 4925.9 5085.9 5142.0 5149.9 5162.8 3617.5 5366.8 5695.6 5747.4 5748.2 5503.6 5639.3 5642.5 5679.9 5696.7 5732.5 5742.0 5769.9 5782.2 5784.4 4899.3 5073.5 5075.0 5079.3 5082.6 11099.0 11756.7 20410.7 20481.5 20598.3 1946.8 1948.7 1992.1 1994.1 2044.3 8729.5 9283.9 9306.3 9353.8 9391.5 1736.9 1750.0 1775.8 1806.6 1835.5 69248.7 70413.6 70490.6 70646.0 71137.6 9873.7 10193.5 10297.6 10358.3 10364.8 14462.7 14519.6 14605.3 14616.1 14696.1 6945.9 6986.8 7026.9 7129.9 7153.9 6512.8 6522.8 6543.1 6621.2 6645.1 4316.3 4343.0 4351.3 4366.4 4403.3 1665.0 1770.9 1877.5 1888.3 1935.9 798.6 867.3 898.8 944.2 983.7 15208.7 16157.7 16250.6 16499.3 16576.8 877.5 896.6 913.4 914.9 951.3 8961.1 9021.3 9054.3 9075.5 9283.3 390922.0 407094.0 413768.0 420431.0 421568.0 47036.0 69906.7 78067.0 80572.0 81179.0 934.9 944.4 951.0 951.1 957.0 14186.7 14361.7 14520.0 14582.0 14697.3 34037.7 34109.0 34400.7 35095.3 35335.6 48739.8 48888.5 48912.3 49284.0 49336.0 7362.4 7449.6 7561.5 7636.8 7657.7 10622.3 11568.8 11604.8 11606.1 12039.3 8955.5 9202.9 9293.6 9624.4 10041.3 9529.5 9609.5 9879.9 10194.5 10511.4 4869.3 7189.4 9143.8 9834.6 10230.2 7466.8 7512.4 7565.8 7568.4 7720.7 9790.8 9854.5 9944.0 10090.3 10169.3 15:45:54 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | [#3] mootools.html Cycles:180 Average:5192.01 Median:5517.88 stddev:2847.33 (51.6%) stddev-sans-first:2841.90 15:45:54 INFO - PROCESS | 4164 | Values: 1514.1 1536.3 1650.4 1744.8 1800.6 6891.9 7458.3 7676.9 7689.3 7748.7 7604.9 7625.8 7709.9 7714.7 7729.9 2255.4 2283.9 2288.0 2292.3 2304.0 2189.0 2219.7 2235.4 2235.6 2237.2 2193.9 2220.2 2233.8 2248.1 2262.9 2219.5 2231.8 2234.8 2236.9 2245.7 2223.9 2224.6 2233.3 2236.4 2241.0 7841.3 7874.1 7925.2 7935.2 7948.0 4606.7 4745.4 4751.2 4762.0 4777.5 2936.9 2986.0 3005.5 3014.7 3043.5 930.5 944.2 946.4 952.4 990.5 10620.6 10641.3 10644.2 10644.7 10703.3 4134.1 4204.1 4348.4 4351.0 4356.3 9067.8 9083.4 9087.1 9108.4 9123.9 4705.9 4708.8 4732.1 4741.5 4746.7 3735.1 4170.1 4299.2 4320.4 4364.1 3694.5 3696.6 3801.9 3812.9 3813.4 1193.1 1198.4 1199.8 1205.8 1208.5 845.5 861.9 883.0 885.2 900.0 5516.3 5519.4 5546.8 5736.0 5758.4 886.5 925.1 930.9 977.4 1011.8 3470.6 3589.3 3709.2 3741.6 3755.1 9469.8 9765.9 9813.3 9902.2 9950.9 9634.4 9651.4 9742.2 9773.6 9855.4 7325.3 7418.7 7435.8 7453.1 7494.9 5403.8 5419.0 5427.8 5460.9 5590.3 8888.7 9008.6 9013.5 9057.1 9138.5 8419.4 8795.9 8829.6 8929.2 9083.3 5892.2 6559.4 6749.9 6886.5 7054.6 7351.6 7357.1 7377.7 7379.5 7423.7 6564.8 6678.0 6757.8 6804.7 6824.2 6543.4 6563.1 6584.1 6660.3 6670.1 6307.0 6361.8 6366.9 6368.6 6408.5 4578.1 4610.8 4679.9 4758.8 4858.9 4649.8 4662.8 4704.8 4706.4 4744.4 15:45:54 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | [#4] prototype.html Cycles:180 Average:4556.95 Median:5225.37 stddev:1321.32 (25.3%) stddev-sans-first:1286.03 15:45:54 INFO - PROCESS | 4164 | Values: 311.8 319.7 325.9 329.5 329.7 5091.5 5142.7 5204.3 5284.8 5292.8 5217.1 5218.1 5232.7 5251.5 5258.3 4043.5 4045.2 4063.3 4063.5 4078.1 3898.6 4028.8 4067.5 4070.6 4076.2 4007.7 4008.2 4015.7 4018.6 4027.7 4011.1 4019.4 4038.3 4039.1 4058.2 3566.9 3571.5 3580.9 3590.7 3593.4 4764.4 4965.6 4983.2 4986.7 4990.3 4650.0 4652.2 4654.1 4666.9 4716.4 5465.9 5475.8 5478.9 5496.3 5526.3 3830.2 3921.1 3928.6 3958.9 3959.0 5701.1 5753.2 5762.7 5764.7 5793.0 4012.6 4013.6 4027.6 4029.1 4031.8 4006.5 4089.9 4095.5 4097.8 4118.8 4676.1 4678.3 4686.0 4690.1 4693.1 5506.6 5515.6 5534.2 5536.3 5552.4 1337.7 1400.8 1443.1 1449.5 1451.6 961.9 982.0 986.3 992.1 1001.2 4737.2 4773.8 4777.5 4779.3 4785.7 5564.3 5607.7 5624.1 5624.5 5643.7 4649.4 4753.1 4762.4 4765.1 4812.6 2947.3 3009.3 3023.6 3029.4 3029.9 5251.5 5296.0 5297.6 5300.6 5345.7 5490.2 5697.4 5742.0 5765.4 5771.2 5302.3 5309.5 5320.1 5320.3 5325.1 5494.3 5595.2 5599.6 5617.8 5630.2 5504.5 5539.9 5541.6 5542.8 5543.0 5306.2 5315.2 5328.2 5341.3 5346.8 3778.8 4070.5 4073.9 4083.7 4091.0 5445.6 5567.0 5687.9 5689.4 5701.8 5566.9 5570.3 5578.0 5585.7 5587.6 5544.9 5546.5 5549.0 5551.4 5569.7 5261.5 5463.1 5474.0 5478.8 5503.8 5513.5 5582.4 5595.9 5597.6 5600.5 5291.0 5402.8 5405.6 5446.9 5475.9 15:45:54 INFO - PROCESS | 4164 | 15:45:54 INFO - PROCESS | 4164 | [#5] yui.html Cycles:180 Average:12934.65 Median:42741.00 stddev:14696.32 (34.4%) stddev-sans-first:14708.80 15:45:54 INFO - PROCESS | 4164 | Values: 694.3 796.8 798.7 803.2 808.1 12170.9 12198.9 12322.0 12474.1 12491.8 12414.8 12455.4 12504.2 12512.6 12544.9 652.5 811.1 820.9 856.7 857.9 832.1 841.2 848.2 848.3 850.0 865.9 876.6 884.6 884.8 886.5 866.3 873.5 877.3 884.1 885.9 637.9 639.0 639.1 642.1 642.2 12994.3 13004.3 13007.4 13011.3 13122.7 12649.0 12748.5 12984.9 13153.8 13339.9 10053.9 10196.6 10262.8 10361.1 10541.2 3318.6 3350.3 3354.3 3355.8 3367.9 45734.3 45755.1 45826.3 47315.5 47518.5 10102.4 10159.8 10235.7 10339.9 10455.7 17997.5 18022.8 18124.4 18134.3 18193.5 7044.2 7217.0 7223.1 7226.7 7282.0 3748.5 3766.1 3836.7 3840.2 3908.7 2892.7 2934.8 2948.7 2952.1 2964.0 521.9 532.2 534.1 534.4 551.1 581.3 650.4 650.5 661.8 667.6 8063.8 8083.2 8219.2 8282.6 8327.0 620.5 623.2 643.0 649.8 656.4 3902.7 3914.2 3933.7 3940.1 4001.9 54310.7 54770.0 55317.7 55476.7 55631.7 46163.5 47704.0 47842.3 47893.5 48614.3 41525.2 42558.0 42924.0 42980.6 43327.8 7587.0 7601.9 8053.7 8244.0 8315.4 26664.2 26837.2 27591.3 27635.7 28561.9 36715.1 38585.2 39503.2 39540.2 39783.8 10497.6 10816.9 10842.6 10843.8 10853.7 11068.2 11110.8 11181.3 11213.1 11282.3 9704.1 10534.4 10890.5 11013.5 11880.1 10708.4 10781.4 10878.2 11078.2 11090.4 10974.6 11002.6 11084.3 11173.2 11239.0 9345.3 9673.9 9678.4 9816.1 9908.8 9559.5 9570.9 9580.5 9592.7 9686.1 15:45:54 INFO - PROCESS | 4164 | -------- Summary: end -------- 15:45:54 INFO - PROCESS | 4164 | 15:45:55 INFO - TEST-INFO | 4164: exit 0 15:45:55 INFO - TEST-OK | dromaeo_css | took 1115308ms 15:45:55 INFO - TEST-START | kraken 15:45:55 INFO - operating with platform_type : linux_ 15:45:55 INFO - Initialising browser for kraken test... 15:45:55 INFO - TEST-INFO | started process 4395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdoSKce/profile http://localhost:56770/getInfo.html) 15:45:59 INFO - PROCESS | 4395 | 15:45:59 INFO - PROCESS | 4395 | (process:4466): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:45:59 INFO - PROCESS | 4395 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:46:00 INFO - PROCESS | 4395 | __metrics Screen width/height:1600/1200 15:46:00 INFO - PROCESS | 4395 | colorDepth:24 15:46:00 INFO - PROCESS | 4395 | Browser inner width/height: 1024/697 15:46:00 INFO - PROCESS | 4395 | __metrics 15:46:01 ERROR - PROCESS | 4395 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:46:01 INFO - TEST-INFO | 4395: exit 0 15:46:01 INFO - Browser initialized. 15:46:01 INFO - Running cycle 1/1 for kraken test... 15:46:01 INFO - TEST-INFO | started process 4517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdoSKce/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:03 INFO - PROCESS | 4517 | 15:46:03 INFO - PROCESS | 4517 | (process:4577): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:46:13 INFO - PROCESS | 4517 | RSS: Main: 164438016 15:46:13 INFO - PROCESS | 4517 | 15:46:16 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56770/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:17 INFO - PROCESS | 4517 | RSS: Main: 168628224 15:46:17 INFO - PROCESS | 4517 | 15:46:20 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56770/tests/kraken/driver.html?testName=audio-dft) 15:46:20 INFO - PROCESS | 4517 | RSS: Main: 172249088 15:46:20 INFO - PROCESS | 4517 | 15:46:23 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56770/tests/kraken/driver.html?testName=audio-fft) 15:46:24 INFO - PROCESS | 4517 | RSS: Main: 163905536 15:46:24 INFO - PROCESS | 4517 | 15:46:26 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56770/tests/kraken/driver.html?testName=audio-oscillator) 15:46:27 INFO - PROCESS | 4517 | RSS: Main: 164777984 15:46:27 INFO - PROCESS | 4517 | 15:46:29 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:30 INFO - PROCESS | 4517 | RSS: Main: 164691968 15:46:30 INFO - PROCESS | 4517 | 15:46:33 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56770/tests/kraken/driver.html?testName=imaging-darkroom) 15:46:33 INFO - PROCESS | 4517 | RSS: Main: 164978688 15:46:33 INFO - PROCESS | 4517 | 15:46:37 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56770/tests/kraken/driver.html?testName=imaging-desaturate) 15:46:37 INFO - PROCESS | 4517 | RSS: Main: 164433920 15:46:37 INFO - PROCESS | 4517 | 15:46:40 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56770/tests/kraken/driver.html?testName=json-parse-financial) 15:46:41 INFO - PROCESS | 4517 | RSS: Main: 165113856 15:46:41 INFO - PROCESS | 4517 | 15:46:43 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:46:43 INFO - PROCESS | 4517 | RSS: Main: 165363712 15:46:43 INFO - PROCESS | 4517 | 15:46:45 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56770/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:46:46 INFO - PROCESS | 4517 | RSS: Main: 165748736 15:46:46 INFO - PROCESS | 4517 | 15:46:48 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:46:49 INFO - PROCESS | 4517 | RSS: Main: 165892096 15:46:49 INFO - PROCESS | 4517 | 15:46:52 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:46:52 INFO - PROCESS | 4517 | RSS: Main: 166125568 15:46:52 INFO - PROCESS | 4517 | 15:46:55 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:46:56 INFO - PROCESS | 4517 | RSS: Main: 166068224 15:46:56 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | Cycle 1(1): loaded http://localhost:56770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56770/tests/kraken/driver.html?testName=ai-astar) 15:46:58 INFO - PROCESS | 4517 | RSS: Main: 167546880 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | __start_tp_report 15:46:58 INFO - PROCESS | 4517 | _x_x_mozilla_page_load 15:46:58 INFO - PROCESS | 4517 | _x_x_mozilla_page_load_details 15:46:58 INFO - PROCESS | 4517 | |i|pagename|runs| 15:46:58 INFO - PROCESS | 4517 | |0;ai-astar;116;107;121;113;113;126;112;112;114;115 15:46:58 INFO - PROCESS | 4517 | |1;audio-beat-detection;164;133;155;197;133;158;158;137;189;134 15:46:58 INFO - PROCESS | 4517 | |2;audio-dft;164;163;163;167;169;163;162;162;165;164 15:46:58 INFO - PROCESS | 4517 | |3;audio-fft;80;77;74;152;74;74;73;74;161;74 15:46:58 INFO - PROCESS | 4517 | |4;audio-oscillator;94;94;151;94;93;92;132;94;94;147 15:46:58 INFO - PROCESS | 4517 | |5;imaging-gaussian-blur;117;118;118;117;118;118;118;117;118;117 15:46:58 INFO - PROCESS | 4517 | |6;imaging-darkroom;146;148;148;147;147;147;147;147;147;148 15:46:58 INFO - PROCESS | 4517 | |7;imaging-desaturate;96;97;96;96;97;97;96;96;96;96 15:46:58 INFO - PROCESS | 4517 | |8;json-parse-financial;63;64;69;64;64;64;63;80;64;63 15:46:58 INFO - PROCESS | 4517 | |9;json-stringify-tinderbox;64;65;65;65;64;63;66;64;65;65 15:46:58 INFO - PROCESS | 4517 | |10;stanford-crypto-aes;84;83;86;84;85;86;85;85;86;84 15:46:58 INFO - PROCESS | 4517 | |11;stanford-crypto-ccm;154;146;139;143;139;136;140;145;182;143 15:46:58 INFO - PROCESS | 4517 | |12;stanford-crypto-pbkdf2;180;181;170;173;179;171;181;180;174;172 15:46:58 INFO - PROCESS | 4517 | |13;stanford-crypto-sha256-iterative;81;71;70;70;75;72;79;70;73;72 15:46:58 INFO - PROCESS | 4517 | __end_tp_report 15:46:58 INFO - PROCESS | 4517 | __start_cc_report 15:46:58 INFO - PROCESS | 4517 | _x_x_mozilla_cycle_collect,889 15:46:58 INFO - PROCESS | 4517 | __end_cc_report 15:46:58 INFO - PROCESS | 4517 | __startTimestamp1460587618392__endTimestamp 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | ------- Summary: start ------- 15:46:58 INFO - PROCESS | 4517 | Number of tests: 14 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.50 stddev:5.26 (4.6%) stddev-sans-first:5.56 15:46:58 INFO - PROCESS | 4517 | Values: 116.0 107.0 121.0 113.0 113.0 126.0 112.0 112.0 114.0 115.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:158.00 stddev:22.96 (14.5%) stddev-sans-first:24.16 15:46:58 INFO - PROCESS | 4517 | Values: 164.0 133.0 155.0 197.0 133.0 158.0 158.0 137.0 189.0 134.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.25 (1.4%) stddev-sans-first:2.39 15:46:58 INFO - PROCESS | 4517 | Values: 164.0 163.0 163.0 167.0 169.0 163.0 162.0 162.0 165.0 164.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#3] audio-fft Cycles:10 Average:91.30 Median:74.00 stddev:34.49 (46.6%) stddev-sans-first:36.34 15:46:58 INFO - PROCESS | 4517 | Values: 80.0 77.0 74.0 152.0 74.0 74.0 73.0 74.0 161.0 74.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:94.00 stddev:24.51 (26.1%) stddev-sans-first:25.42 15:46:58 INFO - PROCESS | 4517 | Values: 94.0 94.0 151.0 94.0 93.0 92.0 132.0 94.0 94.0 147.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:46:58 INFO - PROCESS | 4517 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 15:46:58 INFO - PROCESS | 4517 | Values: 146.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:46:58 INFO - PROCESS | 4517 | Values: 96.0 97.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:64.00 stddev:5.29 (8.3%) stddev-sans-first:5.51 15:46:58 INFO - PROCESS | 4517 | Values: 63.0 64.0 69.0 64.0 64.0 64.0 63.0 80.0 64.0 63.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 15:46:58 INFO - PROCESS | 4517 | Values: 64.0 65.0 65.0 65.0 64.0 63.0 66.0 64.0 65.0 65.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 15:46:58 INFO - PROCESS | 4517 | Values: 84.0 83.0 86.0 84.0 85.0 86.0 85.0 85.0 86.0 84.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:144.00 stddev:13.37 (9.3%) stddev-sans-first:13.91 15:46:58 INFO - PROCESS | 4517 | Values: 154.0 146.0 139.0 143.0 139.0 136.0 140.0 145.0 182.0 143.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:179.50 stddev:4.48 (2.5%) stddev-sans-first:4.53 15:46:58 INFO - PROCESS | 4517 | Values: 180.0 181.0 170.0 173.0 179.0 171.0 181.0 180.0 174.0 172.0 15:46:58 INFO - PROCESS | 4517 | 15:46:58 INFO - PROCESS | 4517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:72.50 stddev:3.89 (5.4%) stddev-sans-first:2.96 15:46:58 INFO - PROCESS | 4517 | Values: 81.0 71.0 70.0 70.0 75.0 72.0 79.0 70.0 73.0 72.0 15:46:58 INFO - PROCESS | 4517 | -------- Summary: end -------- 15:46:58 INFO - PROCESS | 4517 | 15:46:59 INFO - TEST-INFO | 4517: exit 0 15:46:59 INFO - TEST-OK | kraken | took 63701ms 15:46:59 INFO - SUITE-END | took 1179s 15:46:59 INFO - Completed test suite (00:19:39) 15:46:59 INFO - javascript benchmark 15:46:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.3471632091973, 2635.4860802143585, 2663.934426229508, 2666.2267942296735, 2677.5715885458317, 4648.0, 4689.296605509176, 4725.45657249416, 4729.148753224418, 4792.90414191716, 4590.989982203918, 4711.740854253015, 4720.079584481027, 4722.858314250578, 4734.976325118379, 4252.3834044063515, 4313.590208930146, 4347.630451411634, 4374.8906277343, 4421.823127074913, 4360.389545463638, 4377.737335759864, 4400.185965596359, 4417.42573465449, 4459.286514157736, 4063.309237429644, 4324.027093903878, 4340.804663790137, 4410.117976404716, 4433.113377324548, 4295.334223195409, 4310.267254566731, 4313.245182093121, 4322.675799315032, 4362.672799540047, 4295.0, 4300.419443375135, 4306.418633484471, 4330.328799036154, 4335.718178318431, 4457.576530229656, 4560.771961401917, 4602.769861506911, 4629.8148074077, 4641.071785642885, 5006.2740902569285, 5034.823781167642, 5067.898642027176, 5072.898542029138, 5110.66780659256, 4987.700737955734, 5055.0, 5078.695278283315, 5083.6441449098575, 5133.897322053575, 4739.976300118477, 4769.332293478847, 4773.236282194902, 4815.422149342031, 4816.8314109006715, 5074.188129899198, 5104.744762761847, 5117.334746482933, 5124.93396988029, 5153.716545589954, 4880.389951256093, 4923.753812309442, 4926.45808961014, 4963.131451995886, 4986.7257300848805, 5001.699898006132, 5027.245913112989, 5056.216286475602, 5060.3927528696795, 5100.38795344561, 4938.950610493849, 4945.727984960789, 4970.726610036482, 4982.7259500727805, 4985.127602669519, 4866.0511200316305, 4961.751912404366, 4987.650864439454, 5005.649604527648, 5032.3961124665275, 3839.2321535692413, 3873.6320049595242, 3911.2959667260166, 3912.139329347539, 3942.48747662802, 3474.913127171841, 3494.8776792812637, 3496.6852983231634, 3513.9648603514147, 3533.205028868484, 4229.577042295808, 4298.548652391516, 4318.5033721121845, 4380.452443444569, 4406.49325327585, 4971.552560269593, 5013.523715247045, 5052.898942021139, 5080.364954380702, 5120.564751996048, 4319.092990471973, 4333.891652708708, 4337.479502459725, 4338.392625032498, 4387.670924680661, 4392.4289842320295, 4469.798859051285, 4473.664475164375, 4474.440694913136, 4515.841945531956, 4793.9280910785665, 4796.544328288807, 4831.227003679394, 4847.854564363075, 4863.027394521039, 4930.063287975273, 4953.925691114709, 4960.727160006234, 4975.278584605139, 4995.950040499549, 4702.03608260299, 4722.952770472251, 4741.620670346295, 4757.001029783784, 4770.403699537558, 4971.701697898137, 4983.775730092082, 4997.9750101249265, 5008.223725322581, 5039.823606173766, 5065.062963351792, 5065.620078494054, 5082.263071854634, 5089.541941225308, 5129.948700512947, 4773.403324584427, 4888.340074090094, 4902.264660300983, 4928.6057115431395, 4945.851624451272, 4854.5873600744335, 4878.438979517401, 4897.706137631753, 4908.607311415007, 4924.310596516562, 4818.879528011687, 4828.734419606955, 4835.323054772405, 4840.273958906051, 4883.121038213156, 4862.610991120772, 4951.777170027285, 4983.177775666974, 5031.723255220998, 5066.189409694432, 4710.670253082251, 4805.543473370024, 4838.056578967067, 4840.975795121002, 4866.367372241728], "value": 4599.070202102138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.6352607279194, 602.7227475361334, 606.7087797857029, 628.4406877878689, 647.9125318082057, 34086.31827363454, 35184.472232916465, 35236.0, 35526.0, 35530.644693553055, 36427.63572364276, 36761.81619091901, 36996.0, 37028.444573331355, 37170.8141459293, 7502.624868756568, 7706.383489320869, 7760.534367937942, 7760.689572417096, 7763.146053934062, 7533.773986780406, 7706.961465192694, 7756.573388463632, 7774.766756997271, 7795.454318197729, 7791.415643826707, 7797.727079552217, 7831.216878312181, 7833.6083195840265, 7834.804129896741, 7761.0, 7761.728339508147, 7772.805679857992, 7785.571793551352, 7791.883121753178, 7701.499402538817, 7770.883436748453, 7789.922100779033, 7806.531608103532, 7846.686132554691, 31414.685853141404, 36858.0, 36868.81565592182, 36987.81506092479, 37111.628883711084, 3008.6479981301477, 3045.345250771095, 3115.2211947013247, 3137.4352616529245, 3140.450421176285, 24744.25767226986, 26150.215493535223, 27331.590026149624, 27387.589186162222, 28094.157175284774, 3205.5191721241767, 3254.544363789071, 3258.885938992124, 3336.115929278743, 3382.96617033829, 185955.0, 186237.0, 188206.0, 188325.0, 188643.0, 33241.501377479355, 33420.49869251963, 33617.327653446795, 33638.831805841306, 33681.66318336834, 33033.339333213204, 33138.17154571155, 33202.16994575107, 33331.333373332396, 33406.66593334084, 11586.420678966018, 11744.882551174378, 11757.235779674294, 11833.585824496102, 11876.584319548774, 10684.679459616224, 10779.78440431187, 10901.509432075418, 10904.127669786398, 10910.454477276264, 8291.33669306454, 8304.750857474286, 8338.0, 8375.95812020936, 8413.15868413166, 3238.2552013037134, 3278.4590542560686, 3286.983565082159, 3329.067860998924, 3350.430426827445, 861.6553378648465, 895.8521843895815, 924.6347692661361, 929.8837645294338, 958.113744786084, 27075.593866092026, 27577.44845103087, 27640.861795690893, 27796.444071118465, 28181.43637127246, 904.5694130701927, 975.5756246032998, 985.2315194148575, 985.7979114281555, 1058.25921854702, 14285.142891426547, 14500.274986250644, 14572.0, 14699.853001469848, 14707.485238016618, 354625.0, 362625.0, 364375.0, 368584.0, 370903.0, 50817.74591127095, 52418.21372679413, 52424.737876311134, 52595.73702131465, 52759.736201318745, 1240.4418011894504, 1250.0562075632838, 1285.042643230799, 1286.4403984266874, 1287.1762072273566, 26444.603330949667, 27027.0, 27279.0, 27522.587161192998, 27942.86028569844, 43168.56831431771, 44265.0, 44742.3288650677, 44757.328640069776, 45042.099158017314, 316893.0, 322247.0, 323567.0, 323983.0, 324937.0, 26130.0, 26182.0, 26809.597856031785, 26899.596506052032, 26967.247128936557, 44656.10687786291, 44660.55339446694, 44993.55006449894, 45162.0, 45305.50819704948, 37820.43269351017, 37848.0, 38139.0, 38457.615423846524, 38484.42273365846, 36523.37621587704, 36645.816770915975, 37381.25237495289, 37413.625863741014, 38226.426603601525, 29742.702572973994, 30787.38425231438, 31055.84472077625, 34739.13152171216, 35200.471992919614, 29774.851125744233, 32802.0, 36083.63916360803, 36739.26521469609, 37541.2491750158, 24253.51492970166, 24375.75624243806, 24431.51136977286, 24496.265112046665, 24744.65947097191], "value": 16050.493625221174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.92170605025973, 382.5027464296415, 383.4191200331496, 394.1919065914874, 403.513765912076, 15645.452409165682, 16276.860619756622, 16431.34274629015, 16747.665046699072, 16804.74792878108, 15593.298301576428, 15794.526164215093, 16164.0, 16259.674806503863, 16414.17929103543, 4925.876853078675, 5085.949140508603, 5142.0, 5149.897002059956, 5162.845114646567, 3617.5297211362486, 5366.785328586851, 5695.601307908448, 5747.42525747424, 5748.19525266463, 5503.587230957674, 5639.2668953036045, 5642.492175704186, 5679.858003549903, 5696.6866822324755, 5732.455416735404, 5742.0, 5769.913451298213, 5782.219400380936, 5784.363719990798, 4899.2896030075435, 5073.467285934998, 5075.0, 5079.314292570492, 5082.644214904958, 11099.001089901947, 11756.706082347924, 20410.69383959242, 20481.48796280105, 20598.27906023282, 1946.766388033431, 1948.7076938459202, 1992.14337834731, 1994.1425187169657, 2044.3355909329528, 8729.519876406795, 9283.907160928371, 9306.348555601111, 9353.812923741556, 9391.483468409235, 1736.9044702541355, 1749.9912500437417, 1775.7957834849028, 1806.6025474395612, 1835.476889086604, 69248.6537567314, 70413.64793176002, 70490.64754676246, 70646.0, 71137.64431177863, 9873.729042320307, 10193.490325483695, 10297.588096476056, 10358.326708763907, 10364.792704145875, 14462.710745785236, 14519.564413067625, 14605.269736513132, 14616.123032618078, 14696.11823290606, 6945.89581156283, 6986.825329366807, 7026.894596581055, 7129.928700712927, 7153.92846071543, 6512.772052978218, 6522.804315870531, 6543.1166792483355, 6621.205455345293, 6645.06969024337, 4316.3093904975685, 4342.978285108554, 4351.26028575143, 4366.366876802846, 4403.304727679802, 1664.9853677050662, 1770.929162833498, 1877.4649224970817, 1888.2635772048911, 1935.8935258560914, 798.6086817459403, 867.3364875869964, 898.7797989492616, 944.2210176604192, 983.6655537117272, 15208.695826083416, 16157.676846463004, 16250.593735156715, 16499.340026398808, 16576.751348729536, 877.4822854515867, 896.6458248991612, 913.36064754672, 914.8947870994788, 951.3055469507299, 8961.148690874357, 9021.32340074497, 9054.275657947348, 9075.54622268884, 9283.303752218475, 390922.0, 407094.0, 413768.0, 420431.0, 421568.0, 47036.0, 69906.65046674733, 78067.0, 80572.0, 81179.0, 934.8784657994418, 944.4003058058045, 950.9667161649309, 951.1439704266078, 957.0, 14186.716265674835, 14361.712765744836, 14520.0, 14581.986372905296, 14697.265136743334, 34037.65962340444, 34109.0, 34400.65599344075, 35095.29809403849, 35335.64664353323, 48739.756301218265, 48888.51111488982, 48912.266316006004, 49284.0, 49336.0, 7362.4478164136835, 7449.627518623939, 7561.546307221584, 7636.770896873103, 7657.69369225247, 10622.256442048982, 11568.826467603161, 11604.76790464169, 11606.129540284344, 12039.337836419081, 8955.462672239686, 9202.907970920205, 9293.583668246169, 9624.37441566296, 10041.297109202578, 9529.52352382392, 9609.519524023632, 9879.925215704783, 10194.541245643815, 10511.369317840954, 4869.31829543857, 7189.352958233784, 9143.817123657622, 9834.557444915139, 10230.232732545237, 7466.775996720107, 7512.39900807945, 7565.810854728676, 7568.394528437601, 7720.652570634447, 9790.804183916423, 9854.507274636382, 9944.0, 10090.293679442368, 10169.338992965433], "value": 8042.990324187657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.1369419430926, 1536.3086611025037, 1650.3728583138407, 1744.7557341972117, 1800.5678637127094, 6891.896621550681, 7458.328750412462, 7676.92323076769, 7689.307962283387, 7748.651310691018, 7604.923950760491, 7625.771226863189, 7709.922900771005, 7714.652840622171, 7729.884051739228, 2255.4474153832334, 2283.8515496492673, 2288.0275882749847, 2292.3466811958597, 2304.0438218139534, 2188.9781102188936, 2219.678146668732, 2235.35174799308, 2235.6087684655204, 2237.2169740590825, 2193.8793366364844, 2220.1785339424355, 2233.798958093771, 2248.123231939545, 2262.8981695823727, 2219.522802597433, 2231.787980141884, 2234.754177040524, 2236.854604450714, 2245.719285089364, 2223.9110435582556, 2224.610693128696, 2233.2853486884205, 2236.3738153316935, 2240.9775902241095, 7841.294283514511, 7874.133845277015, 7925.247101525346, 7935.246151615645, 7948.0, 4606.700564463299, 4745.3593764842, 4751.192297309466, 4762.047590481918, 4777.5222477752295, 2936.8678409471627, 2986.0295403993787, 3005.4740420426556, 3014.6533148687963, 3043.4978228592254, 930.4928813796497, 944.1785646487531, 946.3706635087658, 952.3952290295712, 990.5195979949718, 10620.57517699291, 10641.308314959502, 10644.201684873588, 10644.733881653021, 10703.304285221435, 4134.111166099303, 4204.13815167896, 4348.412964249849, 4350.956490435118, 4356.346548017823, 9067.773305667279, 9083.409578377385, 9087.09129087086, 9108.362414631045, 9123.863142052875, 4705.882352941204, 4708.788104535304, 4732.148213321566, 4741.525847415231, 4746.715197088186, 3735.0849041984343, 4170.082581831992, 4299.161663475655, 4320.416743739618, 4364.083542456056, 3694.5012423322505, 3696.5564132304294, 3801.923961520754, 3812.8856134316015, 3813.3707938189887, 1193.0694058634278, 1198.3522656347523, 1199.7900367435664, 1205.7709035283267, 1208.468273959455, 845.5222799118478, 861.9051904290523, 883.0463099852144, 885.2254277507182, 900.0234745301291, 5516.3380394352935, 5519.420460851553, 5546.833594992157, 5736.0, 5758.424157584208, 886.4769785826264, 925.0656836595087, 930.8976012638605, 977.4409816342921, 1011.8077565262577, 3470.564141499897, 3589.33597284498, 3709.221063576625, 3741.551013878352, 3755.0987762936697, 9469.810603787886, 9765.902340976641, 9813.264005199639, 9902.158316543175, 9950.900490994998, 9634.421934683942, 9651.372660777028, 9742.171915387271, 9773.560189791477, 9855.35940163887, 7325.304096110861, 7418.740344087931, 7435.814104647319, 7453.142888567776, 7494.925050749423, 5403.83788486346, 5418.972905135449, 5427.83716488506, 5460.91808622863, 5590.301212348457, 8888.73333799987, 9008.594613242289, 9013.459192448474, 9057.139571740674, 9138.497382644018, 8419.36854735885, 8795.91204087951, 8829.60266788009, 8929.24101451358, 9083.318751093562, 5892.234009578728, 6559.442447392025, 6749.886268765598, 6886.48351373639, 7054.576725396492, 7351.558906465629, 7357.0803649543805, 7377.741779037708, 7379.520331178456, 7423.703051877865, 6564.770233041821, 6678.0, 6757.831054223487, 6804.727810887509, 6824.2152152503095, 6543.378379053982, 6563.146790917151, 6584.078229047841, 6660.300668429745, 6670.132882725409, 6307.0, 6361.840953976002, 6366.904496432465, 6368.5860419072615, 6408.519361047846, 4578.084383123322, 4610.838620648261, 4679.876829560949, 4758.785854636619, 4858.92711609319, 4649.816323271135, 4662.813487460599, 4704.811807527661, 4706.435227772689, 4744.4069491313585], "value": 4224.52493636302, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.82849432811963, 319.6723358557478, 325.89897131889114, 329.46790932643785, 329.70491410187884, 5091.541761241488, 5142.66572672776, 5204.323437953066, 5284.841454756359, 5292.788288468466, 5217.113090774568, 5218.060749065176, 5232.686038837673, 5251.505534870935, 5258.316418865552, 4043.5349934757437, 4045.1505183911413, 4063.34986402175, 4063.4717486726686, 4078.1028173801865, 3898.629630185128, 4028.8187031583648, 4067.4712287402745, 4070.613291737295, 4076.2458945095104, 4007.73949693269, 4008.238434697398, 4015.687058177001, 4018.5934922777087, 4027.65764909983, 4011.097503061817, 4019.432421355674, 4038.313486707252, 4039.1113954930015, 4058.1680755445063, 3566.928661426757, 3571.535700358963, 3580.856765729368, 3590.676839084495, 3593.3711600470074, 4764.428268607755, 4965.641320372794, 4983.152864013126, 4986.675866068694, 4990.2764099205415, 4649.953500464986, 4652.185867473178, 4654.115718013567, 4666.929996050062, 4716.38686970695, 5465.945340546584, 5475.835724928219, 5478.863028424321, 5496.31296087989, 5526.281583394133, 3830.157365379612, 3921.117748506592, 3928.607139286077, 3958.8812335629977, 3959.0204897551225, 5701.144828275792, 5753.245260195638, 5762.711864406805, 5764.682942438164, 5793.015187418149, 4012.578679238696, 4013.5585085640555, 4027.6099052033424, 4029.133736246721, 4031.7580945143386, 4006.539247986519, 4089.8773036808943, 4095.508538975342, 4097.815598298083, 4118.8352465901025, 4676.134915040729, 4678.321643361762, 4686.0, 4690.132325519789, 4693.084848454587, 5506.587005974568, 5515.586331025109, 5534.225208470817, 5536.307961504812, 5552.416996215339, 1337.6923307639297, 1400.7828786538103, 1443.1269082205324, 1449.4564538298139, 1451.622578129694, 961.927855410847, 982.0228872272135, 986.2849434160177, 992.1120597065731, 1001.2190491416707, 4737.24204127338, 4773.809047638125, 4777.474477807438, 4779.330893674888, 4785.665003449725, 5564.33228012641, 5607.663540187602, 5624.072028115315, 5624.493795558337, 5643.717814109278, 4649.4420669519195, 4753.096911586787, 4762.357081793983, 4765.142274390573, 4812.614990800727, 2947.292649764041, 3009.277773334384, 3023.576699262105, 3029.409265193266, 3029.909102726922, 5251.501107394792, 5296.0, 5297.576193904479, 5300.628955973122, 5345.705986170798, 5490.203920431595, 5697.379205565403, 5741.971290143606, 5765.423457654201, 5771.249737534094, 5302.337207849019, 5309.522262917718, 5320.122179840283, 5320.281761962163, 5325.147976323769, 5494.269305168859, 5595.160725891149, 5599.60802743804, 5617.775288988395, 5630.18362337467, 5504.4770746778995, 5539.9169012464035, 5541.556675466034, 5542.75057622416, 5542.97228513871, 5306.177542480922, 5315.176147697113, 5328.200769884548, 5341.332333458317, 5346.8395948121615, 3778.848846046237, 4070.4504891839224, 4073.877783666495, 4083.734557253769, 4091.0386059276643, 5445.564354851523, 5566.966003528006, 5687.914681279702, 5689.374168841341, 5701.828945131652, 5566.944330556643, 5570.3315602128005, 5577.991922907669, 5585.69278689676, 5587.5809314302405, 5544.944550554443, 5546.500814926676, 5548.9722551386985, 5551.389347171727, 5569.665820050648, 5261.473852614861, 5463.07127788269, 5474.0, 5478.753456094565, 5503.834884953458, 5513.476219759116, 5582.441755824385, 5595.944040559705, 5597.608167428241, 5600.523955463668, 5290.9735451322495, 5402.838389746224, 5405.594580406564, 5446.891062178814, 5475.890482190413], "value": 4140.901579387003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.2571448550051, 796.7888509544968, 798.680527788884, 803.180755629258, 808.1030056637131, 12170.939145304283, 12198.939005304972, 12322.0, 12474.064445166603, 12491.812622810654, 12414.751704965895, 12455.377231138453, 12504.249745015306, 12512.624621261353, 12544.874551254485, 652.451940370089, 811.1239860950175, 820.8686610142379, 856.6530555125184, 857.9099194584572, 832.0930186097153, 841.2302742990187, 848.245061894914, 848.3425345357366, 849.9532525711084, 865.8657908024267, 876.6099085906774, 884.5842454046619, 884.7743825324533, 886.4548302793768, 866.2506931504266, 873.4802792338548, 877.3332267476732, 884.0584777212248, 885.8671199320089, 637.8660481298933, 639.0, 639.076534407781, 642.0657942693416, 642.2036674523604, 12994.28531430771, 13004.349782510932, 13007.414666340037, 13011.284379359131, 13122.737545249041, 12649.0, 12748.490060397573, 12984.87015129846, 13153.802692959613, 13339.933300333436, 10053.949730251376, 10196.643117490852, 10262.846057309072, 10361.067503924607, 10541.156707463384, 3318.5851768528933, 3350.279689866666, 3354.295597924439, 3355.798652080883, 3367.9494807577908, 45734.313985290246, 45755.084898301844, 45826.31260531062, 47315.5268447318, 47518.5248147521, 10102.444365559817, 10159.796804064024, 10235.749331844163, 10339.896601033894, 10455.68632941013, 17997.460076197734, 18022.819771802377, 18124.365647202285, 18134.274629014955, 18193.45419637413, 7044.22513523512, 7216.96391518039, 7223.097112860893, 7226.7109315626785, 7281.963590182015, 3748.5126933499014, 3766.077311058808, 3836.712246581518, 3840.1551658635058, 3908.7459315144424, 2892.739653431201, 2934.7505462035538, 2948.660903996025, 2952.0848536953613, 2964.021872781977, 521.8538809133448, 532.2495281652929, 534.0973754355127, 534.3667753711863, 551.0741953518047, 581.2501872584319, 650.4016304999412, 650.4796163069525, 661.798151563768, 667.6227931218846, 8063.758087257392, 8083.19168083187, 8219.178082191733, 8282.627281772335, 8326.958365208257, 620.5439002333281, 623.1742940603718, 643.0386572074779, 649.8281035750493, 656.3928366261189, 3902.70729695274, 3914.158455931988, 3933.704972127102, 3940.133170702441, 4001.91996160081, 54310.72844635751, 54770.0, 55317.72341138349, 55476.72261638666, 55631.721841390536, 46163.538364615924, 47704.0, 47842.28236576454, 47893.5210647889, 48614.27078593824, 41525.1694966099, 42558.0, 42924.0, 42980.570194298285, 43327.78336108299, 7586.962065189638, 7601.885971710318, 8053.718119865776, 8244.0, 8315.419337140529, 26664.20007399781, 26837.194884153505, 27591.31021724473, 27635.723642763314, 28561.857190713912, 36715.08212294714, 38585.22829543337, 39503.2099358017, 39540.2091958165, 39783.80108099557, 10497.632582859564, 10816.945915270373, 10842.566297348018, 10843.783124337311, 10853.674389768319, 11068.169887258327, 11110.777784444104, 11181.273217240854, 11213.102951763676, 11282.266652667551, 9704.078112579293, 10534.420606866695, 10890.455477226265, 11013.472762888563, 11880.10899182582, 10708.357498550113, 10781.407022613832, 10878.184136189975, 11078.169137314573, 11090.390028548507, 10974.561017559208, 11002.614908478165, 11084.279521831055, 11173.217874749014, 11239.04468120219, 9345.252379809735, 9673.903260967581, 9678.370905891095, 9816.054760423149, 9908.752281193028, 9559.522023898917, 9570.90429095728, 9580.520973951136, 9592.712218633173, 9686.128248457673], "value": 6075.037489744931, "unit": "score"}], "name": "dromaeo_css", "value": 6309.668826825134, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 107.0, 121.0, 113.0, 113.0, 126.0, 112.0, 112.0, 114.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 133.0, 155.0, 197.0, 133.0, 158.0, 158.0, 137.0, 189.0, 134.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 167.0, 169.0, 163.0, 162.0, 162.0, 165.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 74.0, 152.0, 74.0, 74.0, 73.0, 74.0, 161.0, 74.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 151.0, 94.0, 93.0, 92.0, 132.0, 94.0, 94.0, 147.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 69.0, 64.0, 64.0, 64.0, 63.0, 80.0, 64.0, 63.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 63.0, 66.0, 64.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 86.0, 84.0, 85.0, 86.0, 85.0, 85.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 146.0, 139.0, 143.0, 139.0, 136.0, 140.0, 145.0, 182.0, 143.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 170.0, 173.0, 179.0, 171.0, 181.0, 180.0, 174.0, 172.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 70.0, 70.0, 75.0, 72.0, 79.0, 70.0, 73.0, 72.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1607.0999999999997, "alertThreshold": 2.0}]} 15:46:59 INFO - Return code: 0 15:46:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:46:59 ERROR - # TBPL SUCCESS # 15:46:59 INFO - Running post-action listener: _resource_record_post_action 15:46:59 INFO - Running post-run listener: _resource_record_post_run 15:47:00 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 425984; Write bytes: 297791488; Read time: 40; Write time: 189416 15:47:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13881344; Read time: 0; Write time: 2132 15:47:00 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 425984; Write bytes: 283910144; Read time: 40; Write time: 187284 15:47:00 INFO - Running post-run listener: _upload_blobber_files 15:47:00 INFO - Blob upload gear active. 15:47:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:00 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 15:47:00 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:47:00 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:47:01 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:47:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:01 INFO - (blobuploader) - INFO - Done attempting. 15:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:02 INFO - (blobuploader) - INFO - Done attempting. 15:47:02 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:02 INFO - Return code: 0 15:47:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81933b3027d1e40bb344377d83269231fd750c278c5204e1f532bbcbbaa8e11d22f898eb8f91fe6ae251fd6bcfda77de0328dcfcbb78bdde09bdf7812cec6a8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9bfa821f25b0b141f1c0efab6b4e681749583b08caf1d1ae87a55034fe3ea71ddf05f56abefc13598c17457b5054da534dca21cad17ae397c9f7f3bf7ead9ff"} 15:47:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:02 INFO - Contents: 15:47:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81933b3027d1e40bb344377d83269231fd750c278c5204e1f532bbcbbaa8e11d22f898eb8f91fe6ae251fd6bcfda77de0328dcfcbb78bdde09bdf7812cec6a8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9bfa821f25b0b141f1c0efab6b4e681749583b08caf1d1ae87a55034fe3ea71ddf05f56abefc13598c17457b5054da534dca21cad17ae397c9f7f3bf7ead9ff"} 15:47:02 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:02 INFO - Copying logs to upload dir... 15:47:02 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.745058 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-13 15:47:02.874725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 15:47:02.878485) ========= 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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 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/Firefox-Non-PGO/sha512/81933b3027d1e40bb344377d83269231fd750c278c5204e1f532bbcbbaa8e11d22f898eb8f91fe6ae251fd6bcfda77de0328dcfcbb78bdde09bdf7812cec6a8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9bfa821f25b0b141f1c0efab6b4e681749583b08caf1d1ae87a55034fe3ea71ddf05f56abefc13598c17457b5054da534dca21cad17ae397c9f7f3bf7ead9ff"} build_url:https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/IrVkOy2XT8SXuNuppH0lXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81933b3027d1e40bb344377d83269231fd750c278c5204e1f532bbcbbaa8e11d22f898eb8f91fe6ae251fd6bcfda77de0328dcfcbb78bdde09bdf7812cec6a8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a9bfa821f25b0b141f1c0efab6b4e681749583b08caf1d1ae87a55034fe3ea71ddf05f56abefc13598c17457b5054da534dca21cad17ae397c9f7f3bf7ead9ff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 15:47:02.903472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:47:02.903808) ========= 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=574dc5aafe09851ec43d388c000001b6-1460586174.5056-1104149255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 15:47:02.989220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 15:47:02.989535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 15:47:02.989835) ========= ========= Total master_lag: 0.27 =========