builder: date_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1457727450.28 results: success (0) buildid: 20160311094013 builduid: 5c58504ac47643f29d85badfbb9238f0 revision: 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.276337) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.276806) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.277135) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006360 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.298865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.299164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.314240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.314512) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.367698) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.368000) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.368376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.368695) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 12:17:31-- 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% 47.3M=0s 2016-03-11 12:17:31 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.470942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.471247) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022504 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:30.520543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 12:17:30.520922) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e --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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 12:17:31,748 truncating revision to first 12 chars 2016-03-11 12:17:31,748 Setting DEBUG logging. 2016-03-11 12:17:31,748 attempt 1/10 2016-03-11 12:17:31,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/7c842ac0b9cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 12:17:33,014 unpacking tar archive at: date-7c842ac0b9cc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.558627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 12:17:32.092805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:32.093146) ========= echo 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e'] 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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e program finished with exit code 0 elapsedTime=0.004469 script_repo_revision: '7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:32.142515) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:32.142845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:17:32.153242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-03-11 12:17:32.153665) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-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', 'Date-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date-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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:17:33 INFO - MultiFileLogger online at 20160311 12:17:33 in /builds/slave/test 12:17:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-Non-PGO 12:17:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:33 INFO - {'append_to_log': False, 12:17:33 INFO - 'base_work_dir': '/builds/slave/test', 12:17:33 INFO - 'blob_upload_branch': 'Date-Non-PGO', 12:17:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:33 INFO - 'branch': 'Date-Non-PGO', 12:17:33 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:33 INFO - 'config_files': ('talos/linux_config.py',), 12:17:33 INFO - 'default_actions': ('clobber', 12:17:33 INFO - 'read-buildbot-config', 12:17:33 INFO - 'download-and-extract', 12:17:33 INFO - 'populate-webroot', 12:17:33 INFO - 'create-virtualenv', 12:17:33 INFO - 'install', 12:17:33 INFO - 'run-tests'), 12:17:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:33 INFO - 'download_minidump_stackwalk': True, 12:17:33 INFO - 'download_symbols': 'ondemand', 12:17:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:33 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:33 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:33 INFO - 'installer_path': 'installer.exe', 12:17:33 INFO - 'log_level': 'info', 12:17:33 INFO - 'log_name': 'talos', 12:17:33 INFO - 'log_to_console': True, 12:17:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:17:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:17:33 INFO - 'opt_config_files': (), 12:17:33 INFO - 'pip_index': False, 12:17:33 INFO - 'sps_profile': False, 12:17:33 INFO - 'sps_profile_interval': 0, 12:17:33 INFO - 'suite': 'dromaeojs-e10s', 12:17:33 INFO - 'system_bits': '32', 12:17:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:33 INFO - 'title': 'talos-linux64-ix-067', 12:17:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:33 INFO - 'use_talos_json': True, 12:17:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:33 INFO - 'work_dir': 'build'} 12:17:33 INFO - ##### 12:17:33 INFO - ##### Running clobber step. 12:17:33 INFO - ##### 12:17:33 INFO - Running pre-action listener: _resource_record_pre_action 12:17:33 INFO - Running main action method: clobber 12:17:33 INFO - rmtree: /builds/slave/test/build 12:17:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:33 INFO - Running post-action listener: _resource_record_post_action 12:17:33 INFO - ##### 12:17:33 INFO - ##### Running read-buildbot-config step. 12:17:33 INFO - ##### 12:17:33 INFO - Running pre-action listener: _resource_record_pre_action 12:17:33 INFO - Running main action method: read_buildbot_config 12:17:33 INFO - Using buildbot properties: 12:17:33 INFO - { 12:17:33 INFO - "project": "", 12:17:33 INFO - "product": "firefox", 12:17:33 INFO - "script_repo_revision": "production", 12:17:33 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs-e10s", 12:17:33 INFO - "repository": "", 12:17:33 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs-e10s", 12:17:33 INFO - "buildid": "20160311094013", 12:17:33 INFO - "pgo_build": "False", 12:17:33 INFO - "basedir": "/builds/slave/test", 12:17:33 INFO - "buildnumber": 1, 12:17:33 INFO - "slavename": "talos-linux64-ix-067", 12:17:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:17:33 INFO - "platform": "ubuntu64_hw", 12:17:33 INFO - "scheduler": "tests-date-linux64-talos", 12:17:33 INFO - "branch": "date", 12:17:33 INFO - "repo_path": "projects/date", 12:17:33 INFO - "revision": "7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e", 12:17:33 INFO - "stage_platform": "linux64", 12:17:33 INFO - "builduid": "5c58504ac47643f29d85badfbb9238f0", 12:17:33 INFO - "slavebuilddir": "test" 12:17:33 INFO - } 12:17:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 12:17:33 INFO - Running post-action listener: _resource_record_post_action 12:17:33 INFO - ##### 12:17:33 INFO - ##### Running download-and-extract step. 12:17:33 INFO - ##### 12:17:33 INFO - Running pre-action listener: _resource_record_pre_action 12:17:33 INFO - Running main action method: download_and_extract 12:17:33 INFO - mkdir: /builds/slave/test/build/tests 12:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:33 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:17:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json 12:17:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json 12:17:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:17:35 INFO - Downloaded 1412 bytes. 12:17:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:17:35 INFO - Using the following test package requirements: 12:17:35 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:17:35 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:35 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:17:35 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:35 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 12:17:35 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:35 INFO - u'jsshell-linux-x86_64.zip'], 12:17:35 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:35 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:17:35 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:17:35 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:35 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 12:17:35 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:35 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 12:17:35 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:35 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:17:35 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:17:35 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:17:35 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:17:35 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:17:35 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')]} 12:17:35 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:17:36 INFO - Downloaded 23091831 bytes. 12:17:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:17:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:17:37 INFO - Return code: 0 12:17:37 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:37 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:17:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:17:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:17:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:17:38 INFO - Downloaded 23091831 bytes. 12:17:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:17:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:17:39 INFO - Return code: 0 12:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:39 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:17:40 INFO - Downloaded 10706668 bytes. 12:17:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:17:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:17:40 INFO - Return code: 0 12:17: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')]} 12:17:40 INFO - https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:17:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:17:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:17:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:17:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:17:43 INFO - Downloaded 52848527 bytes. 12:17:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:17:43 INFO - mkdir: /builds/slave/test/properties 12:17:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:43 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:43 INFO - Contents: 12:17:43 INFO - build_url:https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:17:43 INFO - Running post-action listener: _resource_record_post_action 12:17:43 INFO - Running post-action listener: set_extra_try_arguments 12:17:43 INFO - ##### 12:17:43 INFO - ##### Running populate-webroot step. 12:17:43 INFO - ##### 12:17:43 INFO - Running pre-action listener: _resource_record_pre_action 12:17:43 INFO - Running main action method: populate_webroot 12:17:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:43 INFO - '--tppagecycles', 12:17:43 INFO - '7'], 12:17:43 INFO - 'tests': ['tsvgm']}}, 12:17:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:17:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:17:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:17:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:43 INFO - 'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:43 INFO - 'tests': ['damp', 'tps']}, 12:17:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:43 INFO - 'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['damp', 'tps']}, 12:17:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:17:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:43 INFO - 'other': {'tests': ['a11yr', 12:17:43 INFO - 'ts_paint', 12:17:43 INFO - 'tpaint', 12:17:43 INFO - 'sessionrestore', 12:17:43 INFO - 'sessionrestore_no_auto_restore']}, 12:17:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['a11yr', 12:17:43 INFO - 'ts_paint', 12:17:43 INFO - 'tpaint', 12:17:43 INFO - 'sessionrestore', 12:17:43 INFO - 'sessionrestore_no_auto_restore']}, 12:17:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['a11yr', 12:17:43 INFO - 'ts_paint', 12:17:43 INFO - 'tpaint', 12:17:43 INFO - 'sessionrestore', 12:17:43 INFO - 'sessionrestore_no_auto_restore']}, 12:17:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['a11yr', 12:17:43 INFO - 'ts_paint', 12:17:43 INFO - 'tpaint', 12:17:43 INFO - 'sessionrestore', 12:17:43 INFO - 'sessionrestore_no_auto_restore']}, 12:17:43 INFO - 'other_l64': {'tests': ['a11yr', 12:17:43 INFO - 'ts_paint', 12:17:43 INFO - 'tpaint', 12:17:43 INFO - 'sessionrestore', 12:17:43 INFO - 'sessionrestore_no_auto_restore']}, 12:17:43 INFO - 'other_nol64': {'tests': ['a11yr', 12:17:43 INFO - 'ts_paint', 12:17:43 INFO - 'tpaint', 12:17:43 INFO - 'sessionrestore', 12:17:43 INFO - 'sessionrestore_no_auto_restore']}, 12:17:43 INFO - 'svgr': {'tests': ['tsvgx', 12:17:43 INFO - 'tsvgr_opacity', 12:17:43 INFO - 'tart', 12:17:43 INFO - 'tscrollx', 12:17:43 INFO - 'cart']}, 12:17:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['tsvgx', 12:17:43 INFO - 'tsvgr_opacity', 12:17:43 INFO - 'tart', 12:17:43 INFO - 'tscrollx', 12:17:43 INFO - 'cart']}, 12:17:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:43 INFO - 'tests': ['tp5o']}, 12:17:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:43 INFO - 'talos_options': ['--e10s'], 12:17:43 INFO - 'tests': ['tp5o']}, 12:17:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:43 INFO - 'talos_options': ['--xperf_path', 12:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:43 INFO - 'tests': ['tp5n']}, 12:17:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:43 INFO - 'talos_options': ['--e10s', 12:17:43 INFO - '--xperf_path', 12:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:43 INFO - 'tests': ['tp5n']}}, 12:17:43 INFO - 'talos.zip': {'path': '', 12:17:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:43 INFO - Running post-action listener: _resource_record_post_action 12:17:43 INFO - ##### 12:17:43 INFO - ##### Running create-virtualenv step. 12:17:43 INFO - ##### 12:17:43 INFO - Running pre-action listener: _resource_record_pre_action 12:17:43 INFO - Running main action method: create_virtualenv 12:17:43 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:43 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 12:17:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:43 INFO - Using real prefix '/usr' 12:17:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:44 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:46 INFO - Installing pip.................done. 12:17:46 INFO - Return code: 0 12:17:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:17: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', 'pip>=1.5'] in /builds/slave/test/build 12:17: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 pip>=1.5 12:17:46 INFO - Using env: {'DISPLAY': ':0', 12:17:46 INFO - 'HOME': '/home/cltbld', 12:17:46 INFO - 'LANG': 'en_US.UTF-8', 12:17:46 INFO - 'LANGUAGE': 'en_US:en', 12:17:46 INFO - 'LOGNAME': 'cltbld', 12:17:46 INFO - 'MAIL': '/var/mail/cltbld', 12:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:46 INFO - 'MOZ_NO_REMOTE': '1', 12:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:46 INFO - 'NO_EM_RESTART': '1', 12:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:46 INFO - 'PWD': '/builds/slave/test', 12:17:46 INFO - 'SHELL': '/bin/bash', 12:17:46 INFO - 'SHLVL': '1', 12:17:46 INFO - 'TERM': 'linux', 12:17:46 INFO - 'TMOUT': '86400', 12:17:46 INFO - 'USER': 'cltbld', 12:17:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:46 INFO - '_': '/tools/buildbot/bin/python'} 12:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:46 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 12:17:46 INFO - Cleaning up... 12:17:46 INFO - Return code: 0 12:17:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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', '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 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:17: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:17: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 psutil>=0.7.1 12:17:46 INFO - Using env: {'DISPLAY': ':0', 12:17:46 INFO - 'HOME': '/home/cltbld', 12:17:46 INFO - 'LANG': 'en_US.UTF-8', 12:17:46 INFO - 'LANGUAGE': 'en_US:en', 12:17:46 INFO - 'LOGNAME': 'cltbld', 12:17:46 INFO - 'MAIL': '/var/mail/cltbld', 12:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:46 INFO - 'MOZ_NO_REMOTE': '1', 12:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:46 INFO - 'NO_EM_RESTART': '1', 12:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:46 INFO - 'PWD': '/builds/slave/test', 12:17:46 INFO - 'SHELL': '/bin/bash', 12:17:46 INFO - 'SHLVL': '1', 12:17:46 INFO - 'TERM': 'linux', 12:17:46 INFO - 'TMOUT': '86400', 12:17:46 INFO - 'USER': 'cltbld', 12:17:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:46 INFO - '_': '/tools/buildbot/bin/python'} 12:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:46 INFO - Downloading/unpacking psutil>=0.7.1 12:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:48 INFO - Installing collected packages: psutil 12:17:48 INFO - Running setup.py install for psutil 12:17:48 INFO - building 'psutil._psutil_linux' extension 12:17:48 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 12:17:48 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 12:17:48 INFO - building 'psutil._psutil_posix' extension 12:17:48 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 12:17:49 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 12:17:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:49 INFO - Successfully installed psutil 12:17:49 INFO - Cleaning up... 12:17:49 INFO - Return code: 0 12:17:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:17:49 INFO - Using env: {'DISPLAY': ':0', 12:17:49 INFO - 'HOME': '/home/cltbld', 12:17:49 INFO - 'LANG': 'en_US.UTF-8', 12:17:49 INFO - 'LANGUAGE': 'en_US:en', 12:17:49 INFO - 'LOGNAME': 'cltbld', 12:17:49 INFO - 'MAIL': '/var/mail/cltbld', 12:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:49 INFO - 'MOZ_NO_REMOTE': '1', 12:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:49 INFO - 'NO_EM_RESTART': '1', 12:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:49 INFO - 'PWD': '/builds/slave/test', 12:17:49 INFO - 'SHELL': '/bin/bash', 12:17:49 INFO - 'SHLVL': '1', 12:17:49 INFO - 'TERM': 'linux', 12:17:49 INFO - 'TMOUT': '86400', 12:17:49 INFO - 'USER': 'cltbld', 12:17:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:49 INFO - '_': '/tools/buildbot/bin/python'} 12:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:17:51 INFO - Installing collected packages: mozsystemmonitor 12:17:51 INFO - Running setup.py install for mozsystemmonitor 12:17:51 INFO - Successfully installed mozsystemmonitor 12:17:51 INFO - Cleaning up... 12:17:51 INFO - Return code: 0 12:17:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:17:51 INFO - Using env: {'DISPLAY': ':0', 12:17:51 INFO - 'HOME': '/home/cltbld', 12:17:51 INFO - 'LANG': 'en_US.UTF-8', 12:17:51 INFO - 'LANGUAGE': 'en_US:en', 12:17:51 INFO - 'LOGNAME': 'cltbld', 12:17:51 INFO - 'MAIL': '/var/mail/cltbld', 12:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:51 INFO - 'MOZ_NO_REMOTE': '1', 12:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:51 INFO - 'NO_EM_RESTART': '1', 12:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:51 INFO - 'PWD': '/builds/slave/test', 12:17:51 INFO - 'SHELL': '/bin/bash', 12:17:51 INFO - 'SHLVL': '1', 12:17:51 INFO - 'TERM': 'linux', 12:17:51 INFO - 'TMOUT': '86400', 12:17:51 INFO - 'USER': 'cltbld', 12:17:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:51 INFO - '_': '/tools/buildbot/bin/python'} 12:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:51 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:53 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:54 INFO - Downloading docopt-0.6.1.tar.gz 12:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:54 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:54 INFO - Running setup.py install for blobuploader 12:17:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:54 INFO - Running setup.py install for requests 12:17:54 INFO - Running setup.py install for docopt 12:17:54 INFO - Successfully installed blobuploader requests docopt 12:17:54 INFO - Cleaning up... 12:17:54 INFO - Return code: 0 12:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:54 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')]} 12:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:54 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')]} 12:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:54 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 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:17:54 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 12:17:54 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 12:17:54 INFO - Using env: {'DISPLAY': ':0', 12:17:54 INFO - 'HOME': '/home/cltbld', 12:17:54 INFO - 'LANG': 'en_US.UTF-8', 12:17:54 INFO - 'LANGUAGE': 'en_US:en', 12:17:54 INFO - 'LOGNAME': 'cltbld', 12:17:54 INFO - 'MAIL': '/var/mail/cltbld', 12:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:54 INFO - 'MOZ_NO_REMOTE': '1', 12:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:54 INFO - 'NO_EM_RESTART': '1', 12:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:54 INFO - 'PWD': '/builds/slave/test', 12:17:54 INFO - 'SHELL': '/bin/bash', 12:17:54 INFO - 'SHLVL': '1', 12:17:54 INFO - 'TERM': 'linux', 12:17:54 INFO - 'TMOUT': '86400', 12:17:54 INFO - 'USER': 'cltbld', 12:17:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:54 INFO - '_': '/tools/buildbot/bin/python'} 12:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:55 INFO - Running setup.py (path:/tmp/pip-PIxyqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:55 INFO - Running setup.py (path:/tmp/pip-rWtzIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:55 INFO - Running setup.py (path:/tmp/pip-N2EVpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:55 INFO - Running setup.py (path:/tmp/pip-b5BRhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:55 INFO - Running setup.py (path:/tmp/pip-sGu6OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:55 INFO - Running setup.py (path:/tmp/pip-CMnCDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:55 INFO - Running setup.py (path:/tmp/pip-2LULZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:55 INFO - Running setup.py (path:/tmp/pip-fGvsCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:55 INFO - Running setup.py (path:/tmp/pip-gyUHqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:55 INFO - Running setup.py (path:/tmp/pip-9p_b5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:55 INFO - Running setup.py (path:/tmp/pip-xigdZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:55 INFO - Running setup.py (path:/tmp/pip-LNKYwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:56 INFO - Running setup.py (path:/tmp/pip-TtQUtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:56 INFO - Running setup.py (path:/tmp/pip-IDJkc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:56 INFO - Running setup.py (path:/tmp/pip-bKUMEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:56 INFO - Running setup.py (path:/tmp/pip-6Gjvhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:56 INFO - Running setup.py (path:/tmp/pip-emFiVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:56 INFO - Running setup.py install for manifestparser 12:17:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozcrash 12:17:56 INFO - Running setup.py install for mozdebug 12:17:56 INFO - Running setup.py install for mozdevice 12:17:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozfile 12:17:56 INFO - Running setup.py install for mozhttpd 12:17:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozinfo 12:17:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozInstall 12:17:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozleak 12:17:57 INFO - Running setup.py install for mozlog 12:17:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for moznetwork 12:17:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozprocess 12:17:57 INFO - Running setup.py install for mozprofile 12:17:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozrunner 12:17:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozscreenshot 12:17:57 INFO - Running setup.py install for moztest 12:17:58 INFO - Running setup.py install for mozversion 12:17:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:58 INFO - Cleaning up... 12:17:58 INFO - Return code: 0 12:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:58 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 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:17:58 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 12:17:58 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 12:17:58 INFO - Using env: {'DISPLAY': ':0', 12:17:58 INFO - 'HOME': '/home/cltbld', 12:17:58 INFO - 'LANG': 'en_US.UTF-8', 12:17:58 INFO - 'LANGUAGE': 'en_US:en', 12:17:58 INFO - 'LOGNAME': 'cltbld', 12:17:58 INFO - 'MAIL': '/var/mail/cltbld', 12:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:58 INFO - 'MOZ_NO_REMOTE': '1', 12:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:58 INFO - 'NO_EM_RESTART': '1', 12:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:58 INFO - 'PWD': '/builds/slave/test', 12:17:58 INFO - 'SHELL': '/bin/bash', 12:17:58 INFO - 'SHLVL': '1', 12:17:58 INFO - 'TERM': 'linux', 12:17:58 INFO - 'TMOUT': '86400', 12:17:58 INFO - 'USER': 'cltbld', 12:17:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:58 INFO - '_': '/tools/buildbot/bin/python'} 12:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:58 INFO - Running setup.py (path:/tmp/pip-THfaHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:58 INFO - Running setup.py (path:/tmp/pip-LZqDmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:58 INFO - Running setup.py (path:/tmp/pip-d4xMlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:58 INFO - Running setup.py (path:/tmp/pip-E2ZWBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:58 INFO - Running setup.py (path:/tmp/pip-xqHCHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:58 INFO - Running setup.py (path:/tmp/pip-WwujfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:58 INFO - Running setup.py (path:/tmp/pip-l81ra5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:58 INFO - Running setup.py (path:/tmp/pip-Q50s3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:58 INFO - Running setup.py (path:/tmp/pip-l4hWJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:59 INFO - Running setup.py (path:/tmp/pip-xW93kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:59 INFO - Running setup.py (path:/tmp/pip-Hzq9qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:59 INFO - Running setup.py (path:/tmp/pip-EzgQJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:59 INFO - Running setup.py (path:/tmp/pip-Ofh2zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:59 INFO - Running setup.py (path:/tmp/pip-FZN0Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:59 INFO - Running setup.py (path:/tmp/pip-gJW3YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:59 INFO - Running setup.py (path:/tmp/pip-Ekt4YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:59 INFO - Running setup.py (path:/tmp/pip-21NZTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:59 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)) 12:17:59 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:59 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:59 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)) 12:17:59 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)) 12:17:59 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)) 12:17:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:18:01 INFO - Downloading blessings-1.6.tar.gz 12:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:18:01 INFO - Installing collected packages: blessings 12:18:01 INFO - Running setup.py install for blessings 12:18:01 INFO - Successfully installed blessings 12:18:01 INFO - Cleaning up... 12:18:01 INFO - Return code: 0 12:18:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:01 INFO - Reading from file tmpfile_stdout 12:18:01 INFO - Current package versions: 12:18:01 INFO - argparse == 1.2.1 12:18:01 INFO - blessings == 1.6 12:18:01 INFO - blobuploader == 1.2.4 12:18:01 INFO - docopt == 0.6.1 12:18:01 INFO - manifestparser == 1.1 12:18:01 INFO - mozInstall == 1.12 12:18:01 INFO - mozcrash == 0.16 12:18:01 INFO - mozdebug == 0.1 12:18:01 INFO - mozdevice == 0.48 12:18:01 INFO - mozfile == 1.2 12:18:01 INFO - mozhttpd == 0.7 12:18:01 INFO - mozinfo == 0.9 12:18:01 INFO - mozleak == 0.1 12:18:01 INFO - mozlog == 3.1 12:18:01 INFO - moznetwork == 0.27 12:18:01 INFO - mozprocess == 0.22 12:18:01 INFO - mozprofile == 0.28 12:18:01 INFO - mozrunner == 6.11 12:18:01 INFO - mozscreenshot == 0.1 12:18:01 INFO - mozsystemmonitor == 0.0 12:18:01 INFO - moztest == 0.7 12:18:01 INFO - mozversion == 1.4 12:18:01 INFO - psutil == 3.1.1 12:18:01 INFO - requests == 1.2.3 12:18:01 INFO - wsgiref == 0.1.2 12:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 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 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:18:01 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 12:18:01 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 12:18:01 INFO - Using env: {'DISPLAY': ':0', 12:18:01 INFO - 'HOME': '/home/cltbld', 12:18:01 INFO - 'LANG': 'en_US.UTF-8', 12:18:01 INFO - 'LANGUAGE': 'en_US:en', 12:18:01 INFO - 'LOGNAME': 'cltbld', 12:18:01 INFO - 'MAIL': '/var/mail/cltbld', 12:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:01 INFO - 'MOZ_NO_REMOTE': '1', 12:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:01 INFO - 'NO_EM_RESTART': '1', 12:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:01 INFO - 'PWD': '/builds/slave/test', 12:18:01 INFO - 'SHELL': '/bin/bash', 12:18:01 INFO - 'SHLVL': '1', 12:18:01 INFO - 'TERM': 'linux', 12:18:01 INFO - 'TMOUT': '86400', 12:18:01 INFO - 'USER': 'cltbld', 12:18:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:01 INFO - '_': '/tools/buildbot/bin/python'} 12:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 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)) 12:18:02 INFO - Cleaning up... 12:18:02 INFO - Return code: 0 12:18:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:18:02 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')]} 12:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:02 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')]} 12:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:02 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 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:18:02 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 12:18:02 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 12:18:02 INFO - Using env: {'DISPLAY': ':0', 12:18:02 INFO - 'HOME': '/home/cltbld', 12:18:02 INFO - 'LANG': 'en_US.UTF-8', 12:18:02 INFO - 'LANGUAGE': 'en_US:en', 12:18:02 INFO - 'LOGNAME': 'cltbld', 12:18:02 INFO - 'MAIL': '/var/mail/cltbld', 12:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:02 INFO - 'MOZ_NO_REMOTE': '1', 12:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:02 INFO - 'NO_EM_RESTART': '1', 12:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:02 INFO - 'PWD': '/builds/slave/test', 12:18:02 INFO - 'SHELL': '/bin/bash', 12:18:02 INFO - 'SHLVL': '1', 12:18:02 INFO - 'TERM': 'linux', 12:18:02 INFO - 'TMOUT': '86400', 12:18:02 INFO - 'USER': 'cltbld', 12:18:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:02 INFO - '_': '/tools/buildbot/bin/python'} 12:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:02 INFO - Downloading/unpacking jsonschema 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:18:04 INFO - Downloading/unpacking functools32 (from jsonschema) 12:18:04 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 12:18:04 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 12:18:04 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 12:18:04 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 12:18:04 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 12:18:04 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 12:18:04 INFO - Downloading functools32-3.2.3-2.tar.gz 12:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:18:04 INFO - warning: no files found matching '*.txt' 12:18:04 INFO - no previously-included directories found matching 'build' 12:18:04 INFO - no previously-included directories found matching 'dist' 12:18:04 INFO - no previously-included directories found matching '.git*' 12:18:04 INFO - Installing collected packages: jsonschema, functools32 12:18:04 INFO - Running setup.py install for functools32 12:18:04 INFO - warning: no files found matching '*.txt' 12:18:04 INFO - no previously-included directories found matching 'build' 12:18:04 INFO - no previously-included directories found matching 'dist' 12:18:04 INFO - no previously-included directories found matching '.git*' 12:18:04 INFO - Successfully installed jsonschema functools32 12:18:04 INFO - Cleaning up... 12:18:04 INFO - Return code: 0 12:18:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:04 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 0x7f0e979baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', '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 12:18:04 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 12:18:04 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 12:18:04 INFO - Using env: {'DISPLAY': ':0', 12:18:04 INFO - 'HOME': '/home/cltbld', 12:18:04 INFO - 'LANG': 'en_US.UTF-8', 12:18:04 INFO - 'LANGUAGE': 'en_US:en', 12:18:04 INFO - 'LOGNAME': 'cltbld', 12:18:04 INFO - 'MAIL': '/var/mail/cltbld', 12:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:04 INFO - 'MOZ_NO_REMOTE': '1', 12:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:04 INFO - 'NO_EM_RESTART': '1', 12:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:04 INFO - 'PWD': '/builds/slave/test', 12:18:04 INFO - 'SHELL': '/bin/bash', 12:18:04 INFO - 'SHLVL': '1', 12:18:04 INFO - 'TERM': 'linux', 12:18:04 INFO - 'TMOUT': '86400', 12:18:04 INFO - 'USER': 'cltbld', 12:18:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:04 INFO - '_': '/tools/buildbot/bin/python'} 12:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:04 INFO - Downloading/unpacking flake8 12:18:04 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 12:18:04 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 12:18:04 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 12:18:04 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 12:18:04 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 12:18:04 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 12:18:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:18:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:18:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:18:07 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 12:18:07 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 12:18:07 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 12:18:07 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 12:18:07 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 12:18:07 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 12:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:18:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:18:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:18:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:18:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:18:07 INFO - no previously-included directories found matching 'docs/_build' 12:18:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:18:07 INFO - Running setup.py install for pep8 12:18:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:18:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:18:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:18:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:18:07 INFO - no previously-included directories found matching 'docs/_build' 12:18:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:18:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:18:07 INFO - Cleaning up... 12:18:07 INFO - Return code: 0 12:18:07 INFO - Running post-action listener: _resource_record_post_action 12:18:07 INFO - Running post-action listener: _start_resource_monitoring 12:18:07 INFO - Starting resource monitoring. 12:18:07 INFO - ##### 12:18:07 INFO - ##### Running install step. 12:18:07 INFO - ##### 12:18:07 INFO - Running pre-action listener: _resource_record_pre_action 12:18:07 INFO - Running main action method: install 12:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:07 INFO - Reading from file tmpfile_stdout 12:18:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:18:07 INFO - Reading from file tmpfile_stdout 12:18:07 INFO - Output received: 12:18:07 INFO - Usage: mozinstall [options] installer 12:18:07 INFO - Options: 12:18:07 INFO - -h, --help show this help message and exit 12:18:07 INFO - -d DEST, --destination=DEST 12:18:07 INFO - Directory to install application into. [default: 12:18:07 INFO - "/builds/slave/test"] 12:18:07 INFO - --app=APP Application being installed. [default: firefox] 12:18:07 INFO - mkdir: /builds/slave/test/build/application 12:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:18:20 INFO - Reading from file tmpfile_stdout 12:18:20 INFO - Output received: 12:18:20 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:20 INFO - Running post-action listener: _resource_record_post_action 12:18:20 INFO - ##### 12:18:20 INFO - ##### Running run-tests step. 12:18:20 INFO - ##### 12:18:20 INFO - Running pre-action listener: _resource_record_pre_action 12:18:20 INFO - Running main action method: run_tests 12:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:20 INFO - Python 2.7.3 12:18:20 INFO - Return code: 0 12:18:20 INFO - grabbing minidump binary from tooltool 12:18:20 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')]} 12:18:20 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 0x21ce430>, '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 0x2139f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213a3c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:20 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 12:18:20 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 12:18:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:20 INFO - Return code: 0 12:18:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:18:21 INFO - Return code: 0 12:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 12:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 12:18:21 INFO - Using env: {'DISPLAY': ':0', 12:18:21 INFO - 'HOME': '/home/cltbld', 12:18:21 INFO - 'LANG': 'en_US.UTF-8', 12:18:21 INFO - 'LANGUAGE': 'en_US:en', 12:18:21 INFO - 'LOGNAME': 'cltbld', 12:18:21 INFO - 'MAIL': '/var/mail/cltbld', 12:18:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:21 INFO - 'MOZ_NO_REMOTE': '1', 12:18:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:21 INFO - 'NO_EM_RESTART': '1', 12:18:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:21 INFO - 'PWD': '/builds/slave/test', 12:18:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:21 INFO - 'SHELL': '/bin/bash', 12:18:21 INFO - 'SHLVL': '1', 12:18:21 INFO - 'TERM': 'linux', 12:18:21 INFO - 'TMOUT': '86400', 12:18:21 INFO - 'USER': 'cltbld', 12:18:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125', 12:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:21 INFO - '_': '/tools/buildbot/bin/python'} 12:18:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 12:18:21 INFO - mozversion application_buildid: 20160311094013 12:18:21 INFO - mozversion application_changeset: 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e 12:18:21 INFO - mozversion application_display_name: Firefox 12:18:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:21 INFO - mozversion application_name: Firefox 12:18:21 INFO - mozversion application_remotingname: firefox 12:18:21 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 12:18:21 INFO - mozversion application_vendor: Mozilla 12:18:21 INFO - mozversion application_version: 46.0 12:18:21 INFO - mozversion platform_buildid: 20160311094013 12:18:21 INFO - mozversion platform_changeset: 7c842ac0b9cc378ec7b3614d63a63fb02f72ab4e 12:18:21 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 12:18:21 INFO - mozversion platform_version: 46.0 12:18:21 INFO - using testdate: 1457727501 12:18:21 INFO - actual date: 1457727501 12:18:21 INFO - starting webserver on 'localhost:59988' 12:18:21 INFO - SUITE-START | Running 3 tests 12:18:21 INFO - TEST-START | dromaeo_css 12:18:21 INFO - operating with platform_type : linux_ 12:18:21 INFO - Initialising browser for dromaeo_css test... 12:18:22 INFO - TEST-INFO | started process 29534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOgH97u/profile http://localhost:59988/getInfo.html) 12:18:25 INFO - PROCESS | 29534 | 12:18:25 INFO - PROCESS | 29534 | (process:29614): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:18:25 INFO - PROCESS | 29534 | __metrics Screen width/height:1600/1200 12:18:25 INFO - PROCESS | 29534 | colorDepth:24 12:18:25 INFO - PROCESS | 29534 | Browser inner width/height: 1024/697 12:18:25 INFO - PROCESS | 29534 | __metrics 12:18:26 INFO - TEST-INFO | 29534: exit 0 12:18:26 INFO - Browser initialized. 12:18:26 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:26 INFO - TEST-INFO | started process 29662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOgH97u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:27 INFO - PROCESS | 29662 | 12:18:27 INFO - PROCESS | 29662 | (process:29724): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:18:38 INFO - PROCESS | 29662 | RSS: Main: 138526720 12:18:38 INFO - PROCESS | 29662 | 12:19:28 INFO - PROCESS | 29662 | 1457727568089 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] 12:21:35 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:59988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59988/tests/dromaeo/cssquery-ext.html) 12:21:36 INFO - PROCESS | 29662 | RSS: Main: 142508032 12:21:36 INFO - PROCESS | 29662 | 12:24:38 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:59988/tests/dromaeo/cssquery-ext.html (next: http://localhost:59988/tests/dromaeo/cssquery-jquery.html) 12:24:39 INFO - PROCESS | 29662 | RSS: Main: 142245888 12:24:39 INFO - PROCESS | 29662 | 12:27:40 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:59988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59988/tests/dromaeo/cssquery-mootools.html) 12:27:41 INFO - PROCESS | 29662 | RSS: Main: 141602816 12:27:41 INFO - PROCESS | 29662 | 12:30:42 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:59988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59988/tests/dromaeo/cssquery-prototype.html) 12:30:43 INFO - PROCESS | 29662 | RSS: Main: 142323712 12:30:43 INFO - PROCESS | 29662 | 12:33:45 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:59988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59988/tests/dromaeo/cssquery-yui.html) 12:33:46 INFO - PROCESS | 29662 | RSS: Main: 142385152 12:33:46 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | Cycle 1(1): loaded http://localhost:59988/tests/dromaeo/cssquery-yui.html (next: http://localhost:59988/tests/dromaeo/cssquery-dojo.html) 12:36:48 INFO - PROCESS | 29662 | RSS: Main: 143663104 12:36:48 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | __start_tp_report 12:36:48 INFO - PROCESS | 29662 | _x_x_mozilla_page_load 12:36:48 INFO - PROCESS | 29662 | _x_x_mozilla_page_load_details 12:36:48 INFO - PROCESS | 29662 | |i|pagename|runs| 12:36:48 INFO - PROCESS | 29662 | |0;dojo.html;3334.1497918030905;3365.4951757236395;3371.393149233137;3379.526866238727;3395.473701576255;5479.753411096501;5487.972560137204;5511.366192887814;5516.91724624131;5532.972335138329;5458.645188062783;5504.972475137619;5543.501084902358;5549.334079910406;5553.16702494625;4902.65681402302;4954.603631709464;5010.649254552182;5077.619178561604;5086.745662716868;4939.827106051289;5004.549590536851;5007.574356179729;5034.42104158021;5117.744112794346;5018.498150184971;5023.246513023039;5024.246363045554;5035.924461133086;5067.6452648314635;4920.237363208708;4957.677750946177;5005.874853128683;5013.097642424362;5032.069067222557;4873.975630121827;4921.926171107436;4996.575291100261;5002.124628190052;5009.674371165863;5288.101022826128;5311.362636483646;5338.786448542053;5366.302380690485;5414.864628384283;5707.229524014247;5876.676782776945;5918.704064796743;5938.198343223653;5949.434803693643;5930.169776231331;5966.045432730785;5981.192539007222;6024.578279520435;6068.878622427526;5504.559635229172;5514.3658479275;5537.390887002426;5546.58400619951;5562.694051827148;5949.524038076944;5981.6710080945095;6041.335453100155;6041.395860414012;6059.818205453844;5736.569757268138;5806.274215723035;5835.745314757348;5844.736986835603;5861.32594751609;5930;5941.1088336749835;5948.137520059654;5949.672767997715;5970.253718285215;5900.291964964232;5910.468057874812;5923.822285331447;5928.584999050111;5935.910961335583;5773.249477567973;5824.6796426196115;5851.970740146272;5919.763209471573;5964.910526342108;4535.4103966484145;4556.3393307970155;4556.635469162459;4559.156556037077;4585;3960.9009774755864;4081.8571350002608;4095;4111.6299533042165;4128.091819799639;5501.14732216507;5526.253955716007;5598.636088654224;5659.179418984307;5686.459786320293;5904.9704751475965;5947.49446297061;5967.850803729942;5968.4926781224085;5971.0744834550715;5496.285482887199;5606.943930560724;5611.915821262684;5629.690367029771;5635.915461268084;5073.797048118034;5080.644354895122;5117.181250999822;5126.282320475137;5162.225666150108;6107.8473038173515;6133.325334213233;6136.631802091889;6155.384461553809;6168.660723660242;5882.852928676817;5997.520198384032;6013.458788709037;6027.156198132353;6035.879282414415;5977.760889564369;5982.371850955761;6009.54928380382;6032.1856549365275;6081.027035674271;5781.161731548986;5800.941990580209;5825.388334225015;5838.299404071368;5844.181814545882;5866.911996320144;5927.733252003584;5951.464368206882;5952.375000624872;5958.553108516792;5711.114777209539;5732.598718089694;5831.475167234969;5858.970705146447;5885.411458854081;5822.301323841166;5826.796062137805;5863.853403664772;5866.560007999503;5872.383399743137;5627.240322556402;5744.913826292693;5768.567357448292;5792.478676919098;5794.797182098607;5714.20001199824;5816.272965879265;5884.911291411103;5893.616914900518;5914.704264786657;5610.831675049755;5654.915176272277;5667.603267771216;5676.2337084493065;5680.602357835077 12:36:48 INFO - PROCESS | 29662 | |1;ext.html;557.3061538384711;568.0541897740261;579.0503574138414;597.5876645114873;608.77635951737;38323.61676383235;38854.61145388545;38942.61057389425;38951.415728764056;39060.60939390605;39233.8038309808;40034;40136.79931600338;40147.799261003725;40164.799176004155;8625.439346442461;8719.302455803552;8827.646894124227;8829.381943263974;8833.028366879638;8695;8873.157050080265;8882.777930551756;8886.155815197579;8907.77730556738;8773.210411063003;8904.287656987426;8916.955415222916;8938.642454301853;8945.418547794405;8796.34027447944;8869.290456763443;8879.156480134408;8893.28853691703;8897.065808090154;8740.956295218482;8770.649174033031;8859.29125669945;8869.290456763443;8876.289896808305;39543;39651.801740991395;39988;40012.799936000425;40031;3526.1360966563097;3608.8376023079027;3635.4365073413665;3745.606711295302;4002.659773919191;31978.680213197804;32873.17817054569;33190.17024574381;33460.33079338424;33869.15327116842;4122.525909520414;4356.172327257843;4409.713368631029;4427.2695005324085;4443.044745379727;301898;302903;303731;304213;304294;44843.77578112154;46486.76756616195;46783.29825052627;46896.7655161722;62617.37382626115;43945.34081988773;44321.778391108484;44379.778101109936;44612.3308150378;44796;16914.74627880583;17193.82806171922;17195;17202.22589983454;17217.569560760832;13415.731685366238;13595.728085438235;13635.590932272047;13658.795118073038;13705.45178192881;15715.607109822346;15826.44607438734;15859.207039647972;15860.682786344209;15927.840721592867;6113.419225173601;6128.448439640365;6138.938610613926;6141.785037523665;6206.224221972254;921.5115988526092;1031.3141760729031;1057.4395570347729;1109.8168802147554;1167.8948894599528;30194.54708179379;30376.392472150434;30570.235744106132;30722.846385768375;31090.68909310878;1043.3322673488974;1113.933164010162;1176.1590462819127;1191.7914364986093;1214.7752665756864;15115.15048952034;15555.844441555666;15773.763393549107;16115.355385784671;16162;389028;519454;793900;809981;815228;58687.41312586905;59506.702466488256;59587.70206148941;59647.701761491786;59790.10314845281;1510.6827566211218;1513.8637522623017;1520.9391624335124;1526.259764014452;1529.090191336153;29703.702962970092;32215;32626.673733262363;32805.507917381736;33125.66874331226;50590.49409506005;50697.49302506928;50922.490775093254;50969.23546146737;50985.98028039493;283336;288908;289592;289647;290491;35542.28915421729;36072;36426.27147457089;36493.27013459663;36627.816860915525;47063.294050588585;47405.76297118492;47648.761756190994;48009.27986080282;48767.756161220386;39426.60573394344;39977.80011099926;40049.19901601893;40843.38734919038;40854.38718419167;40506.79746601248;40753.59246407498;40902.59097408988;41071.38392924168;41166;39919.20161596694;40027.1994560113;41801.372979404725;42243.57756422397;42607.78696106624;32043.519347209345;32674.83662581672;34904;36360.63639363572;37724;25567.23298301054;27053.458930821667;27407;27762.167134985983;27925.86037069883 12:36:48 INFO - PROCESS | 29662 | |2;jquery.html;390.53916378673165;395.60374187599456;395.6953146077519;396.53209213128514;396.87101691950124;15240;15861.84138158618;17284.827151728477;17848.37530686426;17961.999999999985;10881;11505.769884602303;14714.705705885875;17513.299468021294;17554.824451755478;5054.570361519266;5100.489951004888;5245.973770131144;5253.658512196714;5254.92117618236;5117.744112794346;5186.559142472895;5346.625736198468;5361;5375.274337964363;5169.069567477853;5323.041852466555;5323.733813309319;5338.893222135555;5367.946320536784;5306.893862122736;5481.342238931334;5518.779248830042;5530.806421775239;5536.806211782608;5318.973405132988;5321.2284218788445;5321.973390133025;5326.840194794162;5384.973075134639;13848;19248.23007079729;20511;21378.465538361666;21401.785982140136;2306.2965795432387;2347.9060837566476;2349.271725765001;2423.369923819802;2476.603743401065;9860.359076659994;10011.498275258697;10119.24105692076;11587.942060289644;14052.156870587798;1972.7139564763172;1977.5649357141406;2051.6204502167147;2058.1355830551206;2086.55139145083;59350.70324648392;59887.70056149692;60185.398146018415;61056.38943610551;61311.38688613146;10861.619843305447;11043.282186657842;11347.773044539063;11350.148738844455;11351.943240283746;14314.713705725828;14784;14788.260586970608;14804.889633277548;14813.259337033105;7975.601219939096;8045.718399855977;8151.429399942066;8183.468074575134;8219.465734727224;7675.769726908202;7694.807629809187;7700.499467534592;7735.381169506426;7789.415793815487;4235.661147108224;4478.171538265431;4517.661175411858;4872.610191184696;4952.504749525091;1977.4067779666043;1998.960020799605;2029.52306208041;2031.3804289691786;2036.9833864474065;931.7484279244566;942.4109931292942;949.2026697574071;969.7914948286152;978.046404755372;16394.1802909854;16920.238589263514;16939.407120750962;17789.7331540027;18117.728234076498;907.3013779389833;1003.5333569890037;1012.9392236465835;1018.8522664213648;1034.632705389591;10344.689659310232;10433.321834080913;10558.260921735406;10652.447426757022;10685.786284274427;421882;426871;427042;428621;642301;77013;77859.10429876701;79842;82051.58974205091;84875;1192.3322939154102;1207.287700256835;1225.5159212111166;1225.840640716719;1227.472186959616;16383.180840957666;16437.26032328524;16444.931079479797;16622;16864.747028794824;34811.477827832095;35723;36083.278334433686;37265.81367093147;37547.249055019296;47099;48189.75905120452;48419;49550.75224623854;50043.249351260485;7765.7670269892;7879.133295337623;7925.484843485386;7939.206079392246;7957.164497727887;11284.435778210893;11408.771824563628;11537.884621154017;11639.59261425846;12167.2699638022;10010.949945250228;10011.299209055296;10578.206634502598;10613.469326533488;10767;10322.225833062701;10422.739431514272;10478.842817357898;10975.890241097486;11106.222564420414;9945.900540994497;10531.73619165705;10622;10672.252942293964;10923.781524369628;7734.690612375667;7964.9203507966495;7968.960155199187;7974.960125199569;7991.800204994922;10051.597936082475;10363.274570779973;10444.425556594157;10570.101541368762;10815.783684326112 12:36:48 INFO - PROCESS | 29662 | |3;mootools.html;1570.2462817847434;1581.5413530076278;1780.421363057006;1844.206990993874;1863.329201487465;8176.632051557679;8243.87634185487;8365.74902752917;8413.453125546836;8449.49303041817;8346.958265208665;8392.328613710904;8403.873941890877;8428.53643049632;8451.91548084519;2466.3834041489627;2511.0207019262502;2512.987435062822;2515.421453065796;2523.3691577105724;2515.434027343842;2532.4555220627562;2553.846769193845;2556.6548515950294;2572.5240830446332;2447.5472037673;2485.5526005319034;2489.178571071542;2515.5220508103403;2522.0794410040385;2460.954094509826;2467.5188338274043;2480.193936970483;2487.32842132625;2488.9875550622314;2530.734272901337;2534.3917459809695;2537.6320433537217;2542.6694529711017;2545.847249165056;8295.792605184859;8308.086110527836;8332.875006874901;8339.082700902896;8345.082040975549;5113.974430127862;5223.268742376071;5266.92099618506;5277.788888444496;5286.3127793387;3250.463673493871;3297.868085276586;3307.2228026413773;3308.9245995051706;3347.146477648184;1095.8904109589057;1098.741795678015;1111.6164923101517;1122.4499995002473;1138.760860219355;11624.070074394029;11698.532058717727;11707.7073073173;11758.412079395996;11810.409479526075;4435.112977404532;4486.214912390318;4578.404807375086;4600.976995115003;4633.513481084505;9112.772180695403;9159.450432974043;9159.679411220575;9183.127602877716;9208;5160.967806438727;5185.2999845021195;5191.948080519146;5199.766010529535;5217.947820521822;4781.665283430196;4831.806727730922;4838.709677419366;4873.244647079709;4876.00041991398;3699.9445008324897;3712.9814350928073;3713.7400381973544;3716;3726.7391282609956;1150.8676502202186;1156.2831044752306;1159.0901142603016;1161.7734541764275;1163.8428812110426;1189.9583514576948;1203.7773011992808;1241.9503219871285;1489.6052546075082;1503.4061545689392;7745.922540774633;7799.220077992269;7872;7879.921200787919;7894.447388682737;1177.929324240531;1206.2822620540765;1214.7206142587254;1217.9208351457128;1232.4761976160096;5834.212381328552;5840.182374467578;5845.766169353178;5860.824175274749;5906.616069955439;9778.511074446249;10268;10289.43408112546;10347.327423717434;10415.375077495375;9998.600055997824;10130.949345253226;10165.898341016495;10182.847257291147;10193.337433066827;8026.518408895368;8026.959865200637;8061.959690201512;8076.515409075474;8087.393445491612;7659.31066204022;7742.883856742266;7764.767056988299;7784.065912090586;7798.844023119619;8866.58134698445;9046.864297035418;9178.219851312713;9234.861477077984;9442.763930901783;9428.811423771624;9433.151016408556;9503.714888553355;9570.186534144676;9615.615375384907;7055.541389809646;7088.787336379917;7146.356827885307;7169.426445884421;7174.354308112295;7436.851262974818;7655.119661239029;7672.271134242238;7697.576633284999;7817.882731759142;7158.713651453883;7437.888431673421;7472.476926615085;7609.315161635479;7669.501482403626;7206.2793720627515;7227.927720722936;7328.890066648898;7389.334959853639;7603.2776886195725;7526;7658.081030276402;7661.693532258871;7666.041744781903;7666.4633475656165;6821.658917054227;6874.587524748531;6938.5836849789175;6944.409725173215;6948.722051117898;6967.16394032699;7027.297270272932;7136.5004449690105;7154.821129471805;7202 12:36:48 INFO - PROCESS | 29662 | |4;prototype.html;368.3939918833519;374.84631301166525;378.85603470681144;387.60270722509443;389.19242571663784;6331.525135614836;6361.141245931798;6474.96400575908;6475.320091390401;6520.771772987946;6194.969025154868;6201.627902325852;6410.647414392207;6422.389872962061;6433.517486188532;4922.778474968617;4927.113119638472;4936.753162341886;4943.456219815817;4962.255661650745;4899.510048995107;4957.231629097496;4957.25641153828;4967.031428871372;4975.7263350515705;4895.510448955094;4898.216285394337;4902.730349830758;4917.262410638397;4919.606431485473;4736.644751643623;4800;4809.567138957475;4853.538913803183;4899.657024008321;4269.914601707979;4279.764612946286;4283.807228674717;4284.507281662618;4285.528591854893;5984.640921544721;6074.48366888815;6113.663748493831;6116.418940200719;6130.509559235251;5699.059655156894;5752.07966725322;5764.452377024176;5776.9422305776825;5801.187833703285;6664.166979127609;6732.966335168293;6746.865062698767;6756.290589488082;6757.864842703168;4733.479317275097;4740.905181896343;4793.089313030513;4798.592119669832;4800.4719480857075;6990.510664253505;7065.752698655574;7066.222715501291;7070.29297070294;7075.11561054863;4805.783739731721;4884.731339776346;4886.389201349832;4917.0903382874285;4921.803127874845;4985.775640096204;4987.351644286219;4987.700737955734;4988.625853060962;4999.075171093359;5731.226284451545;5738.540916726652;5747.166660834156;5753.827385178452;5756.366799652119;6745.662716864137;6872.140982377203;6882.69027893746;6884.51808373409;6895.413889819321;1748.9212985415686;1774.5741022154848;1774.8668849836313;1776.342753181331;1776.564741638281;1168.67861338131;1171.1626187276138;1184.7808155491261;1205.1864991130951;1209.2019267283551;6428.325025872309;6456.451201647818;6508.9023664645065;6526.086347911201;6526.28210896801;6997.790066298019;7031.964840175767;7057.470689698293;7060.352367862051;7067.823304417328;6397.424231819158;6498.057781621638;6505.804825855232;6509.925862232679;6621.470282377399;3819.121602031493;3880.3597406427625;3884.475595794588;3890.183061557105;3892.824822882977;7351.117865856131;7411.147718012389;7424.665890034961;7426.554406735613;7429.402678424165;7186.712531498786;7324.37742791858;7370.963145184347;7381.704731810775;7389.8915162726025;7381.11426628808;7390.667419966222;7394.371478424287;7401.259874012556;7412.110546734426;7129.928700712927;7161.140663120251;7168.1756597989815;7191.640417979184;7200.531965422231;6935.653217339012;7040.753573624898;7043.260457652078;7063;7066.081409416743;7369.115706115086;7380.335769780745;7396;7399.48203625741;7402.25977402277;4903.994681090439;4934.728589927445;4953.108440480748;4955.1576232039915;4974.452810190948;7024.5434046786795;7138.39323657495;7146.64266786669;7179.676914538753;7200.71197152108;6968.163820341389;6981.685824138028;7001.964990175016;7005.159380874327;7009.544379615309;6814.693338799865;6900.309969003059;6932.0988271524375;6969;6971.825704357431;6643.966780166262;6829.692663830239;6855.245922948571;6864.828379290558;6879.105716256855;6943.236244013256;6946.930530694628;6979.685914133977;6982.581045137308;7006;6717.899231511629;6718.496112791462;6719.227288861844;6727.360900714424;6741.292164322872 12:36:48 INFO - PROCESS | 29662 | |5;yui.html;833.8624127019042;848.1221935296965;869.495692498351;901.4636291406615;932.8787257656512;14216.147031178136;14258.287085645716;14301.856981430183;14303.856961430383;14387.064840785355;13782.310884455786;13984.860151398483;14004;14028.298585070732;14046.64883377916;736.3851184261148;745.6458182363389;876.3296078499952;878.4948654523643;879.1164879296298;879.7272845417909;885.4687187687368;887.0331338840663;887.3344991256557;890.973270801877;923.1138107416888;927.4667066436825;928.767808047988;928.7910220200469;930.3998920696147;921.387277460488;923.2936803345447;923.930705197113;925.9259259259277;940.6989763275755;703.4934846910216;705.2031204738613;705.403933676048;705.9611721355324;706.6572712234562;13204.207747535083;13229.404676789567;13276.269805160713;13291.601251962456;13308.334583270895;13832.446702131903;13934.58196254114;14000.159990400507;14100.153990760587;14195.858041419557;11580.884191158066;11648.708782280426;11707.239029463057;11820.940895295469;12133.635990920286;3898.3567711327596;3936.3270609990927;3991.820368083443;3993.6605388542007;4059.2287465381482;49273.50726492761;49322.7533862332;50047.49952500465;50193;50198.498015019744;11001.669949901516;11040.723981900355;11083.889161108447;11099.97618669634;11226.158038147172;19341.226350945806;20134;20136.295229666892;20136.295229667183;20193;7479.289467500579;7659.387249020065;7714.166484510128;7784.610769461504;8151.918480815235;4115.279826030433;4205.201011807747;4344.543822898613;4572.565606267399;4572.908541829145;3321.036899299176;3325.717314028335;3328.7836290641517;3335.299587086739;3347.447671134284;577.8584246859547;596.3082823924227;597.6563476001317;600.8167508909737;617.6541136963315;627.9937200627935;680.8093733754557;689.6448329110513;694.4305669351185;710.4103594016954;9792.608295668093;9795.167410770164;9862.260330475243;9994.700158995242;10181.767323839495;620.9627422354673;642.1170890026214;673.6800019990466;692.8995295682098;699.4614147106699;4478.955210447919;4628.120657075145;4633.884152896205;4668.5564871337165;4700;61585.076223856675;62115;62296.37703622996;62369.37630623636;62436.687816560625;55868.72065639646;56236.71881640647;57152.142717859264;58635.12047319294;58767;50415.99168016619;51232.48767512352;51611.741941290806;51629.741851290506;52798.472015280124;9280.860787088333;9486.478243696663;9519.28605354615;9550.426974381558;9621.134097931219;36224;37012.81493592515;37294.627053730204;37383.43924841075;37599.496020158884;44361;44509;46404.30393544167;46755.76622116868;49019.754901225264;10904.018638322588;11823.422601034055;12098.274103553815;12166.902517290275;12206.633800985985;13176.73646527045;13209.801852972405;13303.66740831487;13705.520306789613;13732.244726539737;11403.828942566033;11717.179797414441;11809.291442513477;12012;12619.432125554189;11963;12058.75882482363;12211.633650990485;12219.266843989033;12704.745905081661;11908.76182476363;11980.101492387932;12750.234985900504;13162;13239.271840048505;9751.171150452292;9971.700848974542;10070;10530.842037369599;10585.153187745116;9949.651762188289;10449.21630877672;10458.947705261426;10613.575456981944;10685.305455145392 12:36:48 INFO - PROCESS | 29662 | __end_tp_report 12:36:48 INFO - PROCESS | 29662 | __start_cc_report 12:36:48 INFO - PROCESS | 29662 | _x_x_mozilla_cycle_collect,256 12:36:48 INFO - PROCESS | 29662 | __end_cc_report 12:36:48 INFO - PROCESS | 29662 | __startTimestamp1457728608666__endTimestamp 12:36:48 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | ------- Summary: start ------- 12:36:48 INFO - PROCESS | 29662 | Number of tests: 6 12:36:48 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | [#0] dojo.html Cycles:165 Average:5497.25 Median:5711.11 stddev:606.38 (10.6%) stddev-sans-first:584.02 12:36:48 INFO - PROCESS | 29662 | Values: 3334.1 3365.5 3371.4 3379.5 3395.5 5479.8 5488.0 5511.4 5516.9 5533.0 5458.6 5505.0 5543.5 5549.3 5553.2 4902.7 4954.6 5010.6 5077.6 5086.7 4939.8 5004.5 5007.6 5034.4 5117.7 5018.5 5023.2 5024.2 5035.9 5067.6 4920.2 4957.7 5005.9 5013.1 5032.1 4874.0 4921.9 4996.6 5002.1 5009.7 5288.1 5311.4 5338.8 5366.3 5414.9 5707.2 5876.7 5918.7 5938.2 5949.4 5930.2 5966.0 5981.2 6024.6 6068.9 5504.6 5514.4 5537.4 5546.6 5562.7 5949.5 5981.7 6041.3 6041.4 6059.8 5736.6 5806.3 5835.7 5844.7 5861.3 5930.0 5941.1 5948.1 5949.7 5970.3 5900.3 5910.5 5923.8 5928.6 5935.9 5773.2 5824.7 5852.0 5919.8 5964.9 4535.4 4556.3 4556.6 4559.2 4585.0 3960.9 4081.9 4095.0 4111.6 4128.1 5501.1 5526.3 5598.6 5659.2 5686.5 5905.0 5947.5 5967.9 5968.5 5971.1 5496.3 5606.9 5611.9 5629.7 5635.9 5073.8 5080.6 5117.2 5126.3 5162.2 6107.8 6133.3 6136.6 6155.4 6168.7 5882.9 5997.5 6013.5 6027.2 6035.9 5977.8 5982.4 6009.5 6032.2 6081.0 5781.2 5800.9 5825.4 5838.3 5844.2 5866.9 5927.7 5951.5 5952.4 5958.6 5711.1 5732.6 5831.5 5859.0 5885.4 5822.3 5826.8 5863.9 5866.6 5872.4 5627.2 5744.9 5768.6 5792.5 5794.8 5714.2 5816.3 5884.9 5893.6 5914.7 5610.8 5654.9 5667.6 5676.2 5680.6 12:36:48 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | [#1] ext.html Cycles:180 Average:57479.91 Median:40000.40 stddev:125186.36 (313.0%) stddev-sans-first:125464.59 12:36:48 INFO - PROCESS | 29662 | Values: 557.3 568.1 579.1 597.6 608.8 38323.6 38854.6 38942.6 38951.4 39060.6 39233.8 40034.0 40136.8 40147.8 40164.8 8625.4 8719.3 8827.6 8829.4 8833.0 8695.0 8873.2 8882.8 8886.2 8907.8 8773.2 8904.3 8917.0 8938.6 8945.4 8796.3 8869.3 8879.2 8893.3 8897.1 8741.0 8770.6 8859.3 8869.3 8876.3 39543.0 39651.8 39988.0 40012.8 40031.0 3526.1 3608.8 3635.4 3745.6 4002.7 31978.7 32873.2 33190.2 33460.3 33869.2 4122.5 4356.2 4409.7 4427.3 4443.0 301898.0 302903.0 303731.0 304213.0 304294.0 44843.8 46486.8 46783.3 46896.8 62617.4 43945.3 44321.8 44379.8 44612.3 44796.0 16914.7 17193.8 17195.0 17202.2 17217.6 13415.7 13595.7 13635.6 13658.8 13705.5 15715.6 15826.4 15859.2 15860.7 15927.8 6113.4 6128.4 6138.9 6141.8 6206.2 921.5 1031.3 1057.4 1109.8 1167.9 30194.5 30376.4 30570.2 30722.8 31090.7 1043.3 1113.9 1176.2 1191.8 1214.8 15115.2 15555.8 15773.8 16115.4 16162.0 389028.0 519454.0 793900.0 809981.0 815228.0 58687.4 59506.7 59587.7 59647.7 59790.1 1510.7 1513.9 1520.9 1526.3 1529.1 29703.7 32215.0 32626.7 32805.5 33125.7 50590.5 50697.5 50922.5 50969.2 50986.0 283336.0 288908.0 289592.0 289647.0 290491.0 35542.3 36072.0 36426.3 36493.3 36627.8 47063.3 47405.8 47648.8 48009.3 48767.8 39426.6 39977.8 40049.2 40843.4 40854.4 40506.8 40753.6 40902.6 41071.4 41166.0 39919.2 40027.2 41801.4 42243.6 42607.8 32043.5 32674.8 34904.0 36360.6 37724.0 25567.2 27053.5 27407.0 27762.2 27925.9 12:36:48 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | [#2] jquery.html Cycles:180 Average:26481.70 Median:2449.99 stddev:78275.87 (3195.0%) stddev-sans-first:78470.94 12:36:48 INFO - PROCESS | 29662 | Values: 390.5 395.6 395.7 396.5 396.9 15240.0 15861.8 17284.8 17848.4 17962.0 10881.0 11505.8 14714.7 17513.3 17554.8 5054.6 5100.5 5246.0 5253.7 5254.9 5117.7 5186.6 5346.6 5361.0 5375.3 5169.1 5323.0 5323.7 5338.9 5367.9 5306.9 5481.3 5518.8 5530.8 5536.8 5319.0 5321.2 5322.0 5326.8 5385.0 13848.0 19248.2 20511.0 21378.5 21401.8 2306.3 2347.9 2349.3 2423.4 2476.6 9860.4 10011.5 10119.2 11587.9 14052.2 1972.7 1977.6 2051.6 2058.1 2086.6 59350.7 59887.7 60185.4 61056.4 61311.4 10861.6 11043.3 11347.8 11350.1 11351.9 14314.7 14784.0 14788.3 14804.9 14813.3 7975.6 8045.7 8151.4 8183.5 8219.5 7675.8 7694.8 7700.5 7735.4 7789.4 4235.7 4478.2 4517.7 4872.6 4952.5 1977.4 1999.0 2029.5 2031.4 2037.0 931.7 942.4 949.2 969.8 978.0 16394.2 16920.2 16939.4 17789.7 18117.7 907.3 1003.5 1012.9 1018.9 1034.6 10344.7 10433.3 10558.3 10652.4 10685.8 421882.0 426871.0 427042.0 428621.0 642301.0 77013.0 77859.1 79842.0 82051.6 84875.0 1192.3 1207.3 1225.5 1225.8 1227.5 16383.2 16437.3 16444.9 16622.0 16864.7 34811.5 35723.0 36083.3 37265.8 37547.2 47099.0 48189.8 48419.0 49550.8 50043.2 7765.8 7879.1 7925.5 7939.2 7957.2 11284.4 11408.8 11537.9 11639.6 12167.3 10010.9 10011.3 10578.2 10613.5 10767.0 10322.2 10422.7 10478.8 10975.9 11106.2 9945.9 10531.7 10622.0 10672.3 10923.8 7734.7 7964.9 7969.0 7975.0 7991.8 10051.6 10363.3 10444.4 10570.1 10815.8 12:36:48 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | [#3] mootools.html Cycles:180 Average:5878.56 Median:5272.35 stddev:3027.01 (57.4%) stddev-sans-first:3018.18 12:36:48 INFO - PROCESS | 29662 | Values: 1570.2 1581.5 1780.4 1844.2 1863.3 8176.6 8243.9 8365.7 8413.5 8449.5 8347.0 8392.3 8403.9 8428.5 8451.9 2466.4 2511.0 2513.0 2515.4 2523.4 2515.4 2532.5 2553.8 2556.7 2572.5 2447.5 2485.6 2489.2 2515.5 2522.1 2461.0 2467.5 2480.2 2487.3 2489.0 2530.7 2534.4 2537.6 2542.7 2545.8 8295.8 8308.1 8332.9 8339.1 8345.1 5114.0 5223.3 5266.9 5277.8 5286.3 3250.5 3297.9 3307.2 3308.9 3347.1 1095.9 1098.7 1111.6 1122.4 1138.8 11624.1 11698.5 11707.7 11758.4 11810.4 4435.1 4486.2 4578.4 4601.0 4633.5 9112.8 9159.5 9159.7 9183.1 9208.0 5161.0 5185.3 5191.9 5199.8 5217.9 4781.7 4831.8 4838.7 4873.2 4876.0 3699.9 3713.0 3713.7 3716.0 3726.7 1150.9 1156.3 1159.1 1161.8 1163.8 1190.0 1203.8 1242.0 1489.6 1503.4 7745.9 7799.2 7872.0 7879.9 7894.4 1177.9 1206.3 1214.7 1217.9 1232.5 5834.2 5840.2 5845.8 5860.8 5906.6 9778.5 10268.0 10289.4 10347.3 10415.4 9998.6 10130.9 10165.9 10182.8 10193.3 8026.5 8027.0 8062.0 8076.5 8087.4 7659.3 7742.9 7764.8 7784.1 7798.8 8866.6 9046.9 9178.2 9234.9 9442.8 9428.8 9433.2 9503.7 9570.2 9615.6 7055.5 7088.8 7146.4 7169.4 7174.4 7436.9 7655.1 7672.3 7697.6 7817.9 7158.7 7437.9 7472.5 7609.3 7669.5 7206.3 7227.9 7328.9 7389.3 7603.3 7526.0 7658.1 7661.7 7666.0 7666.5 6821.7 6874.6 6938.6 6944.4 6948.7 6967.2 7027.3 7136.5 7154.8 7202.0 12:36:48 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | [#4] prototype.html Cycles:180 Average:5750.47 Median:6475.14 stddev:1731.67 (26.7%) stddev-sans-first:1688.75 12:36:48 INFO - PROCESS | 29662 | Values: 368.4 374.8 378.9 387.6 389.2 6331.5 6361.1 6475.0 6475.3 6520.8 6195.0 6201.6 6410.6 6422.4 6433.5 4922.8 4927.1 4936.8 4943.5 4962.3 4899.5 4957.2 4957.3 4967.0 4975.7 4895.5 4898.2 4902.7 4917.3 4919.6 4736.6 4800.0 4809.6 4853.5 4899.7 4269.9 4279.8 4283.8 4284.5 4285.5 5984.6 6074.5 6113.7 6116.4 6130.5 5699.1 5752.1 5764.5 5776.9 5801.2 6664.2 6733.0 6746.9 6756.3 6757.9 4733.5 4740.9 4793.1 4798.6 4800.5 6990.5 7065.8 7066.2 7070.3 7075.1 4805.8 4884.7 4886.4 4917.1 4921.8 4985.8 4987.4 4987.7 4988.6 4999.1 5731.2 5738.5 5747.2 5753.8 5756.4 6745.7 6872.1 6882.7 6884.5 6895.4 1748.9 1774.6 1774.9 1776.3 1776.6 1168.7 1171.2 1184.8 1205.2 1209.2 6428.3 6456.5 6508.9 6526.1 6526.3 6997.8 7032.0 7057.5 7060.4 7067.8 6397.4 6498.1 6505.8 6509.9 6621.5 3819.1 3880.4 3884.5 3890.2 3892.8 7351.1 7411.1 7424.7 7426.6 7429.4 7186.7 7324.4 7371.0 7381.7 7389.9 7381.1 7390.7 7394.4 7401.3 7412.1 7129.9 7161.1 7168.2 7191.6 7200.5 6935.7 7040.8 7043.3 7063.0 7066.1 7369.1 7380.3 7396.0 7399.5 7402.3 4904.0 4934.7 4953.1 4955.2 4974.5 7024.5 7138.4 7146.6 7179.7 7200.7 6968.2 6981.7 7002.0 7005.2 7009.5 6814.7 6900.3 6932.1 6969.0 6971.8 6644.0 6829.7 6855.2 6864.8 6879.1 6943.2 6946.9 6979.7 6982.6 7006.0 6717.9 6718.5 6719.2 6727.4 6741.3 12:36:48 INFO - PROCESS | 29662 | 12:36:48 INFO - PROCESS | 29662 | [#5] yui.html Cycles:180 Average:14881.45 Median:4600.51 stddev:17184.62 (373.5%) stddev-sans-first:17200.45 12:36:48 INFO - PROCESS | 29662 | Values: 833.9 848.1 869.5 901.5 932.9 14216.1 14258.3 14301.9 14303.9 14387.1 13782.3 13984.9 14004.0 14028.3 14046.6 736.4 745.6 876.3 878.5 879.1 879.7 885.5 887.0 887.3 891.0 923.1 927.5 928.8 928.8 930.4 921.4 923.3 923.9 925.9 940.7 703.5 705.2 705.4 706.0 706.7 13204.2 13229.4 13276.3 13291.6 13308.3 13832.4 13934.6 14000.2 14100.2 14195.9 11580.9 11648.7 11707.2 11820.9 12133.6 3898.4 3936.3 3991.8 3993.7 4059.2 49273.5 49322.8 50047.5 50193.0 50198.5 11001.7 11040.7 11083.9 11100.0 11226.2 19341.2 20134.0 20136.3 20136.3 20193.0 7479.3 7659.4 7714.2 7784.6 8151.9 4115.3 4205.2 4344.5 4572.6 4572.9 3321.0 3325.7 3328.8 3335.3 3347.4 577.9 596.3 597.7 600.8 617.7 628.0 680.8 689.6 694.4 710.4 9792.6 9795.2 9862.3 9994.7 10181.8 621.0 642.1 673.7 692.9 699.5 4479.0 4628.1 4633.9 4668.6 4700.0 61585.1 62115.0 62296.4 62369.4 62436.7 55868.7 56236.7 57152.1 58635.1 58767.0 50416.0 51232.5 51611.7 51629.7 52798.5 9280.9 9486.5 9519.3 9550.4 9621.1 36224.0 37012.8 37294.6 37383.4 37599.5 44361.0 44509.0 46404.3 46755.8 49019.8 10904.0 11823.4 12098.3 12166.9 12206.6 13176.7 13209.8 13303.7 13705.5 13732.2 11403.8 11717.2 11809.3 12012.0 12619.4 11963.0 12058.8 12211.6 12219.3 12704.7 11908.8 11980.1 12750.2 13162.0 13239.3 9751.2 9971.7 10070.0 10530.8 10585.2 9949.7 10449.2 10458.9 10613.6 10685.3 12:36:48 INFO - PROCESS | 29662 | -------- Summary: end -------- 12:36:48 INFO - PROCESS | 29662 | 12:36:49 INFO - TEST-INFO | 29662: exit 0 12:36:49 INFO - TEST-OK | dromaeo_css | took 1107211ms 12:36:49 INFO - TEST-START | kraken 12:36:49 INFO - operating with platform_type : linux_ 12:36:49 INFO - Initialising browser for kraken test... 12:36:49 INFO - TEST-INFO | started process 29904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpldq8SF/profile http://localhost:59988/getInfo.html) 12:36:52 INFO - PROCESS | 29904 | 12:36:52 INFO - PROCESS | 29904 | (process:29986): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:36:53 INFO - PROCESS | 29904 | __metrics Screen width/height:1600/1200 12:36:53 INFO - PROCESS | 29904 | colorDepth:24 12:36:53 INFO - PROCESS | 29904 | Browser inner width/height: 1024/697 12:36:53 INFO - PROCESS | 29904 | __metrics 12:36:53 INFO - TEST-INFO | 29904: exit 0 12:36:53 INFO - Browser initialized. 12:36:53 INFO - Running cycle 1/1 for kraken test... 12:36:53 INFO - TEST-INFO | started process 30034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpldq8SF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:55 INFO - PROCESS | 30034 | 12:36:55 INFO - PROCESS | 30034 | (process:30098): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:37:05 INFO - PROCESS | 30034 | RSS: Main: 137830400 12:37:05 INFO - PROCESS | 30034 | 12:37:08 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59988/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:08 INFO - PROCESS | 30034 | RSS: Main: 142049280 12:37:08 INFO - PROCESS | 30034 | 12:37:11 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59988/tests/kraken/driver.html?testName=audio-dft) 12:37:11 INFO - PROCESS | 30034 | RSS: Main: 142856192 12:37:11 INFO - PROCESS | 30034 | 12:37:14 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59988/tests/kraken/driver.html?testName=audio-fft) 12:37:15 INFO - PROCESS | 30034 | RSS: Main: 143478784 12:37:15 INFO - PROCESS | 30034 | 12:37:17 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59988/tests/kraken/driver.html?testName=audio-oscillator) 12:37:17 INFO - PROCESS | 30034 | RSS: Main: 143728640 12:37:17 INFO - PROCESS | 30034 | 12:37:20 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:20 INFO - PROCESS | 30034 | RSS: Main: 143781888 12:37:20 INFO - PROCESS | 30034 | 12:37:23 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59988/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:24 INFO - PROCESS | 30034 | RSS: Main: 142372864 12:37:24 INFO - PROCESS | 30034 | 12:37:27 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59988/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:28 INFO - PROCESS | 30034 | RSS: Main: 142323712 12:37:28 INFO - PROCESS | 30034 | 12:37:30 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59988/tests/kraken/driver.html?testName=json-parse-financial) 12:37:31 INFO - PROCESS | 30034 | RSS: Main: 143081472 12:37:31 INFO - PROCESS | 30034 | 12:37:33 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:33 INFO - PROCESS | 30034 | RSS: Main: 142405632 12:37:33 INFO - PROCESS | 30034 | 12:37:35 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59988/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:36 INFO - PROCESS | 30034 | RSS: Main: 144138240 12:37:36 INFO - PROCESS | 30034 | 12:37:38 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:38 INFO - PROCESS | 30034 | RSS: Main: 144523264 12:37:38 INFO - PROCESS | 30034 | 12:37:41 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:41 INFO - PROCESS | 30034 | RSS: Main: 144523264 12:37:41 INFO - PROCESS | 30034 | 12:37:44 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:44 INFO - PROCESS | 30034 | RSS: Main: 142663680 12:37:44 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | Cycle 1(1): loaded http://localhost:59988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59988/tests/kraken/driver.html?testName=ai-astar) 12:37:46 INFO - PROCESS | 30034 | RSS: Main: 145403904 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | __start_tp_report 12:37:46 INFO - PROCESS | 30034 | _x_x_mozilla_page_load 12:37:46 INFO - PROCESS | 30034 | _x_x_mozilla_page_load_details 12:37:46 INFO - PROCESS | 30034 | |i|pagename|runs| 12:37:46 INFO - PROCESS | 30034 | |0;ai-astar;118;105;113;110;110;120;109;111;112;111 12:37:46 INFO - PROCESS | 30034 | |1;audio-beat-detection;153;124;150;169;126;156;152;133;165;128 12:37:46 INFO - PROCESS | 30034 | |2;audio-dft;164;162;164;164;165;163;165;162;164;161 12:37:46 INFO - PROCESS | 30034 | |3;audio-fft;76;75;72;161;76;73;75;76;156;73 12:37:46 INFO - PROCESS | 30034 | |4;audio-oscillator;95;97;142;94;95;95;147;95;95;142 12:37:46 INFO - PROCESS | 30034 | |5;imaging-gaussian-blur;109;110;112;114;109;110;109;109;109;109 12:37:46 INFO - PROCESS | 30034 | |6;imaging-darkroom;148;147;146;146;146;147;146;149;146;146 12:37:46 INFO - PROCESS | 30034 | |7;imaging-desaturate;96;97;95;96;96;96;97;96;97;96 12:37:46 INFO - PROCESS | 30034 | |8;json-parse-financial;56;59;59;61;58;59;59;60;58;57 12:37:46 INFO - PROCESS | 30034 | |9;json-stringify-tinderbox;64;65;64;64;65;65;64;64;65;64 12:37:46 INFO - PROCESS | 30034 | |10;stanford-crypto-aes;84;84;79;78;79;80;79;78;79;85 12:37:46 INFO - PROCESS | 30034 | |11;stanford-crypto-ccm;114;109;117;120;115;125;110;112;116;112 12:37:46 INFO - PROCESS | 30034 | |12;stanford-crypto-pbkdf2;133;134;133;127;133;143;120;133;146;139 12:37:46 INFO - PROCESS | 30034 | |13;stanford-crypto-sha256-iterative;64;67;72;64;65;66;64;65;63;64 12:37:46 INFO - PROCESS | 30034 | __end_tp_report 12:37:46 INFO - PROCESS | 30034 | __start_cc_report 12:37:46 INFO - PROCESS | 30034 | _x_x_mozilla_cycle_collect,708 12:37:46 INFO - PROCESS | 30034 | __end_cc_report 12:37:46 INFO - PROCESS | 30034 | __startTimestamp1457728666496__endTimestamp 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | ------- Summary: start ------- 12:37:46 INFO - PROCESS | 30034 | Number of tests: 14 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.33 (3.9%) stddev-sans-first:3.99 12:37:46 INFO - PROCESS | 30034 | Values: 118.0 105.0 113.0 110.0 110.0 120.0 109.0 111.0 112.0 111.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:152.50 stddev:16.55 (10.9%) stddev-sans-first:17.34 12:37:46 INFO - PROCESS | 30034 | Values: 153.0 124.0 150.0 169.0 126.0 156.0 152.0 133.0 165.0 128.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 12:37:46 INFO - PROCESS | 30034 | Values: 164.0 162.0 164.0 164.0 165.0 163.0 165.0 162.0 164.0 161.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#3] audio-fft Cycles:10 Average:91.30 Median:75.00 stddev:35.47 (47.3%) stddev-sans-first:37.18 12:37:46 INFO - PROCESS | 30034 | Values: 76.0 75.0 72.0 161.0 76.0 73.0 75.0 76.0 156.0 73.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:95.00 stddev:23.49 (24.7%) stddev-sans-first:24.31 12:37:46 INFO - PROCESS | 30034 | Values: 95.0 97.0 142.0 94.0 95.0 95.0 147.0 95.0 95.0 142.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:109.50 stddev:1.70 (1.6%) stddev-sans-first:1.76 12:37:46 INFO - PROCESS | 30034 | Values: 109.0 110.0 112.0 114.0 109.0 110.0 109.0 109.0 109.0 109.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.06 (0.7%) stddev-sans-first:1.01 12:37:46 INFO - PROCESS | 30034 | Values: 148.0 147.0 146.0 146.0 146.0 147.0 146.0 149.0 146.0 146.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 12:37:46 INFO - PROCESS | 30034 | Values: 96.0 97.0 95.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.00 stddev:1.43 (2.4%) stddev-sans-first:1.17 12:37:46 INFO - PROCESS | 30034 | Values: 56.0 59.0 59.0 61.0 58.0 59.0 59.0 60.0 58.0 57.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 12:37:46 INFO - PROCESS | 30034 | Values: 64.0 65.0 64.0 64.0 65.0 65.0 64.0 64.0 65.0 64.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.50 stddev:2.72 (3.4%) stddev-sans-first:2.57 12:37:46 INFO - PROCESS | 30034 | Values: 84.0 84.0 79.0 78.0 79.0 80.0 79.0 78.0 79.0 85.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.50 stddev:4.83 (4.2%) stddev-sans-first:5.11 12:37:46 INFO - PROCESS | 30034 | Values: 114.0 109.0 117.0 120.0 115.0 125.0 110.0 112.0 116.0 112.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.10 Median:133.50 stddev:7.45 (5.6%) stddev-sans-first:7.89 12:37:46 INFO - PROCESS | 30034 | Values: 133.0 134.0 133.0 127.0 133.0 143.0 120.0 133.0 146.0 139.0 12:37:46 INFO - PROCESS | 30034 | 12:37:46 INFO - PROCESS | 30034 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:2.59 (4.0%) stddev-sans-first:2.70 12:37:46 INFO - PROCESS | 30034 | Values: 64.0 67.0 72.0 64.0 65.0 66.0 64.0 65.0 63.0 64.0 12:37:46 INFO - PROCESS | 30034 | -------- Summary: end -------- 12:37:46 INFO - PROCESS | 30034 | 12:37:47 INFO - TEST-INFO | 30034: exit 0 12:37:47 INFO - TEST-OK | kraken | took 57996ms 12:37:47 INFO - TEST-START | v8_7 12:37:47 INFO - operating with platform_type : linux_ 12:37:47 INFO - Initialising browser for v8_7 test... 12:37:47 INFO - TEST-INFO | started process 30325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB8qhUp/profile http://localhost:59988/getInfo.html) 12:37:50 INFO - PROCESS | 30325 | 12:37:50 INFO - PROCESS | 30325 | (process:30407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:37:50 INFO - PROCESS | 30325 | __metrics Screen width/height:1600/1200 12:37:50 INFO - PROCESS | 30325 | colorDepth:24 12:37:50 INFO - PROCESS | 30325 | Browser inner width/height: 1024/697 12:37:50 INFO - PROCESS | 30325 | __metrics 12:37:51 INFO - TEST-INFO | 30325: exit 0 12:37:51 INFO - Browser initialized. 12:37:51 INFO - Running cycle 1/1 for v8_7 test... 12:37:51 INFO - TEST-INFO | started process 30455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB8qhUp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:52 INFO - PROCESS | 30455 | 12:37:52 INFO - PROCESS | 30455 | (process:30519): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:38:03 INFO - PROCESS | 30455 | RSS: Main: 139354112 12:38:03 INFO - PROCESS | 30455 | 12:38:25 INFO - PROCESS | 30455 | Cycle 1(1): loaded http://localhost:59988/tests/v8_7/run.html (next: http://localhost:59988/tests/v8_7/run.html) 12:38:26 INFO - PROCESS | 30455 | RSS: Main: 141414400 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | __start_tp_report 12:38:26 INFO - PROCESS | 30455 | _x_x_mozilla_page_load 12:38:26 INFO - PROCESS | 30455 | _x_x_mozilla_page_load_details 12:38:26 INFO - PROCESS | 30455 | |i|pagename|runs| 12:38:26 INFO - PROCESS | 30455 | |0;Richards;167.1402306535183 12:38:26 INFO - PROCESS | 30455 | |1;DeltaBlue;166.58337497917708 12:38:26 INFO - PROCESS | 30455 | |2;Encrypt;278.473962684489 12:38:26 INFO - PROCESS | 30455 | |3;Decrypt;5191.709844559586 12:38:26 INFO - PROCESS | 30455 | |4;RayTrace;922.509225092251 12:38:26 INFO - PROCESS | 30455 | |5;Earley;559.9104143337066 12:38:26 INFO - PROCESS | 30455 | |6;Boyer;10891.304347826086 12:38:26 INFO - PROCESS | 30455 | |7;RegExp;38634.61538461538 12:38:26 INFO - PROCESS | 30455 | |8;Splay;499.2511233150275 12:38:26 INFO - PROCESS | 30455 | |9;NavierStokes;4817.307692307692 12:38:26 INFO - PROCESS | 30455 | __end_tp_report 12:38:26 INFO - PROCESS | 30455 | __startTimestamp1457728706027__endTimestamp 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | ------- Summary: start ------- 12:38:26 INFO - PROCESS | 30455 | Number of tests: 10 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 167.1 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#1] DeltaBlue Cycles:1 Average:166.58 Median:166.58 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 166.6 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 278.5 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 5191.7 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#4] RayTrace Cycles:1 Average:922.51 Median:922.51 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 922.5 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#5] Earley Cycles:1 Average:559.91 Median:559.91 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 559.9 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#6] Boyer Cycles:1 Average:10891.30 Median:10891.30 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 10891.3 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#7] RegExp Cycles:1 Average:38634.62 Median:38634.62 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 38634.6 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#8] Splay Cycles:1 Average:499.25 Median:499.25 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 499.3 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - PROCESS | 30455 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 12:38:26 INFO - PROCESS | 30455 | Values: 4817.3 12:38:26 INFO - PROCESS | 30455 | -------- Summary: end -------- 12:38:26 INFO - PROCESS | 30455 | 12:38:26 INFO - TEST-INFO | 30455: exit 0 12:38:26 INFO - TEST-OK | v8_7 | took 39537ms 12:38:26 INFO - SUITE-END | took 1204s 12:38:27 INFO - Completed test suite (00:20:05) 12:38:27 INFO - Working with test: dromaeo_css 12:38:27 INFO - Generating results file: dromaeo_css 12:38:27 INFO - Working with test: kraken 12:38:27 INFO - Generating results file: kraken 12:38:27 INFO - javascript benchmark 12:38:27 INFO - Working with test: v8_7 12:38:27 INFO - Generating results file: v8_7 12:38:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,43]] 12:38:27 INFO - process_Request line: dromaeo_css 7350.72 graph.html#tests=[[72,181,43]] 12:38:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:27 INFO - process_Request line: kraken 1492.80 graph.html#tests=[[232,181,43]] 12:38:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:27 INFO - process_Request line: v8_7 22267.94 graph.html#tests=[[230,181,43]] 12:38:27 INFO - RETURN: dromaeo_css: 7350.72 12:38:27 INFO - RETURN: kraken: 1492.80 12:38:27 INFO - RETURN: v8_7: 22267.94 12:38:27 INFO - javascript benchmark 12:38:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3334.1497918030905, 3365.4951757236395, 3371.393149233137, 3379.526866238727, 3395.473701576255, 5479.753411096501, 5487.972560137204, 5511.366192887814, 5516.91724624131, 5532.972335138329, 5458.645188062783, 5504.972475137619, 5543.501084902358, 5549.334079910406, 5553.16702494625, 4902.65681402302, 4954.603631709464, 5010.649254552182, 5077.619178561604, 5086.745662716868, 4939.827106051289, 5004.549590536851, 5007.574356179729, 5034.42104158021, 5117.744112794346, 5018.498150184971, 5023.246513023039, 5024.246363045554, 5035.924461133086, 5067.6452648314635, 4920.237363208708, 4957.677750946177, 5005.874853128683, 5013.097642424362, 5032.069067222557, 4873.975630121827, 4921.926171107436, 4996.575291100261, 5002.124628190052, 5009.674371165863, 5288.101022826128, 5311.362636483646, 5338.786448542053, 5366.302380690485, 5414.864628384283, 5707.229524014247, 5876.676782776945, 5918.704064796743, 5938.198343223653, 5949.434803693643, 5930.169776231331, 5966.045432730785, 5981.192539007222, 6024.578279520435, 6068.878622427526, 5504.559635229172, 5514.3658479275, 5537.390887002426, 5546.58400619951, 5562.694051827148, 5949.524038076944, 5981.6710080945095, 6041.335453100155, 6041.395860414012, 6059.818205453844, 5736.569757268138, 5806.274215723035, 5835.745314757348, 5844.736986835603, 5861.32594751609, 5930.0, 5941.1088336749835, 5948.137520059654, 5949.672767997715, 5970.253718285215, 5900.291964964232, 5910.468057874812, 5923.822285331447, 5928.584999050111, 5935.910961335583, 5773.249477567973, 5824.6796426196115, 5851.970740146272, 5919.763209471573, 5964.910526342108, 4535.4103966484145, 4556.3393307970155, 4556.635469162459, 4559.156556037077, 4585.0, 3960.9009774755864, 4081.8571350002608, 4095.0, 4111.6299533042165, 4128.091819799639, 5501.14732216507, 5526.253955716007, 5598.636088654224, 5659.179418984307, 5686.459786320293, 5904.9704751475965, 5947.49446297061, 5967.850803729942, 5968.4926781224085, 5971.0744834550715, 5496.285482887199, 5606.943930560724, 5611.915821262684, 5629.690367029771, 5635.915461268084, 5073.797048118034, 5080.644354895122, 5117.181250999822, 5126.282320475137, 5162.225666150108, 6107.8473038173515, 6133.325334213233, 6136.631802091889, 6155.384461553809, 6168.660723660242, 5882.852928676817, 5997.520198384032, 6013.458788709037, 6027.156198132353, 6035.879282414415, 5977.760889564369, 5982.371850955761, 6009.54928380382, 6032.1856549365275, 6081.027035674271, 5781.161731548986, 5800.941990580209, 5825.388334225015, 5838.299404071368, 5844.181814545882, 5866.911996320144, 5927.733252003584, 5951.464368206882, 5952.375000624872, 5958.553108516792, 5711.114777209539, 5732.598718089694, 5831.475167234969, 5858.970705146447, 5885.411458854081, 5822.301323841166, 5826.796062137805, 5863.853403664772, 5866.560007999503, 5872.383399743137, 5627.240322556402, 5744.913826292693, 5768.567357448292, 5792.478676919098, 5794.797182098607, 5714.20001199824, 5816.272965879265, 5884.911291411103, 5893.616914900518, 5914.704264786657, 5610.831675049755, 5654.915176272277, 5667.603267771216, 5676.2337084493065, 5680.602357835077], "unit": "score", "name": "dojo.html", "value": 5458.45766546505}, {"lowerIsBetter": false, "replicates": [557.3061538384711, 568.0541897740261, 579.0503574138414, 597.5876645114873, 608.77635951737, 38323.61676383235, 38854.61145388545, 38942.61057389425, 38951.415728764056, 39060.60939390605, 39233.8038309808, 40034.0, 40136.79931600338, 40147.799261003725, 40164.799176004155, 8625.439346442461, 8719.302455803552, 8827.646894124227, 8829.381943263974, 8833.028366879638, 8695.0, 8873.157050080265, 8882.777930551756, 8886.155815197579, 8907.77730556738, 8773.210411063003, 8904.287656987426, 8916.955415222916, 8938.642454301853, 8945.418547794405, 8796.34027447944, 8869.290456763443, 8879.156480134408, 8893.28853691703, 8897.065808090154, 8740.956295218482, 8770.649174033031, 8859.29125669945, 8869.290456763443, 8876.289896808305, 39543.0, 39651.801740991395, 39988.0, 40012.799936000425, 40031.0, 3526.1360966563097, 3608.8376023079027, 3635.4365073413665, 3745.606711295302, 4002.659773919191, 31978.680213197804, 32873.17817054569, 33190.17024574381, 33460.33079338424, 33869.15327116842, 4122.525909520414, 4356.172327257843, 4409.713368631029, 4427.2695005324085, 4443.044745379727, 301898.0, 302903.0, 303731.0, 304213.0, 304294.0, 44843.77578112154, 46486.76756616195, 46783.29825052627, 46896.7655161722, 62617.37382626115, 43945.34081988773, 44321.778391108484, 44379.778101109936, 44612.3308150378, 44796.0, 16914.74627880583, 17193.82806171922, 17195.0, 17202.22589983454, 17217.569560760832, 13415.731685366238, 13595.728085438235, 13635.590932272047, 13658.795118073038, 13705.45178192881, 15715.607109822346, 15826.44607438734, 15859.207039647972, 15860.682786344209, 15927.840721592867, 6113.419225173601, 6128.448439640365, 6138.938610613926, 6141.785037523665, 6206.224221972254, 921.5115988526092, 1031.3141760729031, 1057.4395570347729, 1109.8168802147554, 1167.8948894599528, 30194.54708179379, 30376.392472150434, 30570.235744106132, 30722.846385768375, 31090.68909310878, 1043.3322673488974, 1113.933164010162, 1176.1590462819127, 1191.7914364986093, 1214.7752665756864, 15115.15048952034, 15555.844441555666, 15773.763393549107, 16115.355385784671, 16162.0, 389028.0, 519454.0, 793900.0, 809981.0, 815228.0, 58687.41312586905, 59506.702466488256, 59587.70206148941, 59647.701761491786, 59790.10314845281, 1510.6827566211218, 1513.8637522623017, 1520.9391624335124, 1526.259764014452, 1529.090191336153, 29703.702962970092, 32215.0, 32626.673733262363, 32805.507917381736, 33125.66874331226, 50590.49409506005, 50697.49302506928, 50922.490775093254, 50969.23546146737, 50985.98028039493, 283336.0, 288908.0, 289592.0, 289647.0, 290491.0, 35542.28915421729, 36072.0, 36426.27147457089, 36493.27013459663, 36627.816860915525, 47063.294050588585, 47405.76297118492, 47648.761756190994, 48009.27986080282, 48767.756161220386, 39426.60573394344, 39977.80011099926, 40049.19901601893, 40843.38734919038, 40854.38718419167, 40506.79746601248, 40753.59246407498, 40902.59097408988, 41071.38392924168, 41166.0, 39919.20161596694, 40027.1994560113, 41801.372979404725, 42243.57756422397, 42607.78696106624, 32043.519347209345, 32674.83662581672, 34904.0, 36360.63639363572, 37724.0, 25567.23298301054, 27053.458930821667, 27407.0, 27762.167134985983, 27925.86037069883], "unit": "score", "name": "ext.html", "value": 19524.796744892894}, {"lowerIsBetter": false, "replicates": [390.53916378673165, 395.60374187599456, 395.6953146077519, 396.53209213128514, 396.87101691950124, 15240.0, 15861.84138158618, 17284.827151728477, 17848.37530686426, 17961.999999999985, 10881.0, 11505.769884602303, 14714.705705885875, 17513.299468021294, 17554.824451755478, 5054.570361519266, 5100.489951004888, 5245.973770131144, 5253.658512196714, 5254.92117618236, 5117.744112794346, 5186.559142472895, 5346.625736198468, 5361.0, 5375.274337964363, 5169.069567477853, 5323.041852466555, 5323.733813309319, 5338.893222135555, 5367.946320536784, 5306.893862122736, 5481.342238931334, 5518.779248830042, 5530.806421775239, 5536.806211782608, 5318.973405132988, 5321.2284218788445, 5321.973390133025, 5326.840194794162, 5384.973075134639, 13848.0, 19248.23007079729, 20511.0, 21378.465538361666, 21401.785982140136, 2306.2965795432387, 2347.9060837566476, 2349.271725765001, 2423.369923819802, 2476.603743401065, 9860.359076659994, 10011.498275258697, 10119.24105692076, 11587.942060289644, 14052.156870587798, 1972.7139564763172, 1977.5649357141406, 2051.6204502167147, 2058.1355830551206, 2086.55139145083, 59350.70324648392, 59887.70056149692, 60185.398146018415, 61056.38943610551, 61311.38688613146, 10861.619843305447, 11043.282186657842, 11347.773044539063, 11350.148738844455, 11351.943240283746, 14314.713705725828, 14784.0, 14788.260586970608, 14804.889633277548, 14813.259337033105, 7975.601219939096, 8045.718399855977, 8151.429399942066, 8183.468074575134, 8219.465734727224, 7675.769726908202, 7694.807629809187, 7700.499467534592, 7735.381169506426, 7789.415793815487, 4235.661147108224, 4478.171538265431, 4517.661175411858, 4872.610191184696, 4952.504749525091, 1977.4067779666043, 1998.960020799605, 2029.52306208041, 2031.3804289691786, 2036.9833864474065, 931.7484279244566, 942.4109931292942, 949.2026697574071, 969.7914948286152, 978.046404755372, 16394.1802909854, 16920.238589263514, 16939.407120750962, 17789.7331540027, 18117.728234076498, 907.3013779389833, 1003.5333569890037, 1012.9392236465835, 1018.8522664213648, 1034.632705389591, 10344.689659310232, 10433.321834080913, 10558.260921735406, 10652.447426757022, 10685.786284274427, 421882.0, 426871.0, 427042.0, 428621.0, 642301.0, 77013.0, 77859.10429876701, 79842.0, 82051.58974205091, 84875.0, 1192.3322939154102, 1207.287700256835, 1225.5159212111166, 1225.840640716719, 1227.472186959616, 16383.180840957666, 16437.26032328524, 16444.931079479797, 16622.0, 16864.747028794824, 34811.477827832095, 35723.0, 36083.278334433686, 37265.81367093147, 37547.249055019296, 47099.0, 48189.75905120452, 48419.0, 49550.75224623854, 50043.249351260485, 7765.7670269892, 7879.133295337623, 7925.484843485386, 7939.206079392246, 7957.164497727887, 11284.435778210893, 11408.771824563628, 11537.884621154017, 11639.59261425846, 12167.2699638022, 10010.949945250228, 10011.299209055296, 10578.206634502598, 10613.469326533488, 10767.0, 10322.225833062701, 10422.739431514272, 10478.842817357898, 10975.890241097486, 11106.222564420414, 9945.900540994497, 10531.73619165705, 10622.0, 10672.252942293964, 10923.781524369628, 7734.690612375667, 7964.9203507966495, 7968.960155199187, 7974.960125199569, 7991.800204994922, 10051.597936082475, 10363.274570779973, 10444.425556594157, 10570.101541368762, 10815.783684326112], "unit": "score", "name": "jquery.html", "value": 8632.201361536996}, {"lowerIsBetter": false, "replicates": [1570.2462817847434, 1581.5413530076278, 1780.421363057006, 1844.206990993874, 1863.329201487465, 8176.632051557679, 8243.87634185487, 8365.74902752917, 8413.453125546836, 8449.49303041817, 8346.958265208665, 8392.328613710904, 8403.873941890877, 8428.53643049632, 8451.91548084519, 2466.3834041489627, 2511.0207019262502, 2512.987435062822, 2515.421453065796, 2523.3691577105724, 2515.434027343842, 2532.4555220627562, 2553.846769193845, 2556.6548515950294, 2572.5240830446332, 2447.5472037673, 2485.5526005319034, 2489.178571071542, 2515.5220508103403, 2522.0794410040385, 2460.954094509826, 2467.5188338274043, 2480.193936970483, 2487.32842132625, 2488.9875550622314, 2530.734272901337, 2534.3917459809695, 2537.6320433537217, 2542.6694529711017, 2545.847249165056, 8295.792605184859, 8308.086110527836, 8332.875006874901, 8339.082700902896, 8345.082040975549, 5113.974430127862, 5223.268742376071, 5266.92099618506, 5277.788888444496, 5286.3127793387, 3250.463673493871, 3297.868085276586, 3307.2228026413773, 3308.9245995051706, 3347.146477648184, 1095.8904109589057, 1098.741795678015, 1111.6164923101517, 1122.4499995002473, 1138.760860219355, 11624.070074394029, 11698.532058717727, 11707.7073073173, 11758.412079395996, 11810.409479526075, 4435.112977404532, 4486.214912390318, 4578.404807375086, 4600.976995115003, 4633.513481084505, 9112.772180695403, 9159.450432974043, 9159.679411220575, 9183.127602877716, 9208.0, 5160.967806438727, 5185.2999845021195, 5191.948080519146, 5199.766010529535, 5217.947820521822, 4781.665283430196, 4831.806727730922, 4838.709677419366, 4873.244647079709, 4876.00041991398, 3699.9445008324897, 3712.9814350928073, 3713.7400381973544, 3716.0, 3726.7391282609956, 1150.8676502202186, 1156.2831044752306, 1159.0901142603016, 1161.7734541764275, 1163.8428812110426, 1189.9583514576948, 1203.7773011992808, 1241.9503219871285, 1489.6052546075082, 1503.4061545689392, 7745.922540774633, 7799.220077992269, 7872.0, 7879.921200787919, 7894.447388682737, 1177.929324240531, 1206.2822620540765, 1214.7206142587254, 1217.9208351457128, 1232.4761976160096, 5834.212381328552, 5840.182374467578, 5845.766169353178, 5860.824175274749, 5906.616069955439, 9778.511074446249, 10268.0, 10289.43408112546, 10347.327423717434, 10415.375077495375, 9998.600055997824, 10130.949345253226, 10165.898341016495, 10182.847257291147, 10193.337433066827, 8026.518408895368, 8026.959865200637, 8061.959690201512, 8076.515409075474, 8087.393445491612, 7659.31066204022, 7742.883856742266, 7764.767056988299, 7784.065912090586, 7798.844023119619, 8866.58134698445, 9046.864297035418, 9178.219851312713, 9234.861477077984, 9442.763930901783, 9428.811423771624, 9433.151016408556, 9503.714888553355, 9570.186534144676, 9615.615375384907, 7055.541389809646, 7088.787336379917, 7146.356827885307, 7169.426445884421, 7174.354308112295, 7436.851262974818, 7655.119661239029, 7672.271134242238, 7697.576633284999, 7817.882731759142, 7158.713651453883, 7437.888431673421, 7472.476926615085, 7609.315161635479, 7669.501482403626, 7206.2793720627515, 7227.927720722936, 7328.890066648898, 7389.334959853639, 7603.2776886195725, 7526.0, 7658.081030276402, 7661.693532258871, 7666.041744781903, 7666.4633475656165, 6821.658917054227, 6874.587524748531, 6938.5836849789175, 6944.409725173215, 6948.722051117898, 6967.16394032699, 7027.297270272932, 7136.5004449690105, 7154.821129471805, 7202.0], "unit": "score", "name": "mootools.html", "value": 4847.315998883937}, {"lowerIsBetter": false, "replicates": [368.3939918833519, 374.84631301166525, 378.85603470681144, 387.60270722509443, 389.19242571663784, 6331.525135614836, 6361.141245931798, 6474.96400575908, 6475.320091390401, 6520.771772987946, 6194.969025154868, 6201.627902325852, 6410.647414392207, 6422.389872962061, 6433.517486188532, 4922.778474968617, 4927.113119638472, 4936.753162341886, 4943.456219815817, 4962.255661650745, 4899.510048995107, 4957.231629097496, 4957.25641153828, 4967.031428871372, 4975.7263350515705, 4895.510448955094, 4898.216285394337, 4902.730349830758, 4917.262410638397, 4919.606431485473, 4736.644751643623, 4800.0, 4809.567138957475, 4853.538913803183, 4899.657024008321, 4269.914601707979, 4279.764612946286, 4283.807228674717, 4284.507281662618, 4285.528591854893, 5984.640921544721, 6074.48366888815, 6113.663748493831, 6116.418940200719, 6130.509559235251, 5699.059655156894, 5752.07966725322, 5764.452377024176, 5776.9422305776825, 5801.187833703285, 6664.166979127609, 6732.966335168293, 6746.865062698767, 6756.290589488082, 6757.864842703168, 4733.479317275097, 4740.905181896343, 4793.089313030513, 4798.592119669832, 4800.4719480857075, 6990.510664253505, 7065.752698655574, 7066.222715501291, 7070.29297070294, 7075.11561054863, 4805.783739731721, 4884.731339776346, 4886.389201349832, 4917.0903382874285, 4921.803127874845, 4985.775640096204, 4987.351644286219, 4987.700737955734, 4988.625853060962, 4999.075171093359, 5731.226284451545, 5738.540916726652, 5747.166660834156, 5753.827385178452, 5756.366799652119, 6745.662716864137, 6872.140982377203, 6882.69027893746, 6884.51808373409, 6895.413889819321, 1748.9212985415686, 1774.5741022154848, 1774.8668849836313, 1776.342753181331, 1776.564741638281, 1168.67861338131, 1171.1626187276138, 1184.7808155491261, 1205.1864991130951, 1209.2019267283551, 6428.325025872309, 6456.451201647818, 6508.9023664645065, 6526.086347911201, 6526.28210896801, 6997.790066298019, 7031.964840175767, 7057.470689698293, 7060.352367862051, 7067.823304417328, 6397.424231819158, 6498.057781621638, 6505.804825855232, 6509.925862232679, 6621.470282377399, 3819.121602031493, 3880.3597406427625, 3884.475595794588, 3890.183061557105, 3892.824822882977, 7351.117865856131, 7411.147718012389, 7424.665890034961, 7426.554406735613, 7429.402678424165, 7186.712531498786, 7324.37742791858, 7370.963145184347, 7381.704731810775, 7389.8915162726025, 7381.11426628808, 7390.667419966222, 7394.371478424287, 7401.259874012556, 7412.110546734426, 7129.928700712927, 7161.140663120251, 7168.1756597989815, 7191.640417979184, 7200.531965422231, 6935.653217339012, 7040.753573624898, 7043.260457652078, 7063.0, 7066.081409416743, 7369.115706115086, 7380.335769780745, 7396.0, 7399.48203625741, 7402.25977402277, 4903.994681090439, 4934.728589927445, 4953.108440480748, 4955.1576232039915, 4974.452810190948, 7024.5434046786795, 7138.39323657495, 7146.64266786669, 7179.676914538753, 7200.71197152108, 6968.163820341389, 6981.685824138028, 7001.964990175016, 7005.159380874327, 7009.544379615309, 6814.693338799865, 6900.309969003059, 6932.0988271524375, 6969.0, 6971.825704357431, 6643.966780166262, 6829.692663830239, 6855.245922948571, 6864.828379290558, 6879.105716256855, 6943.236244013256, 6946.930530694628, 6979.685914133977, 6982.581045137308, 7006.0, 6717.899231511629, 6718.496112791462, 6719.227288861844, 6727.360900714424, 6741.292164322872], "unit": "score", "name": "prototype.html", "value": 5195.391259220238}, {"lowerIsBetter": false, "replicates": [833.8624127019042, 848.1221935296965, 869.495692498351, 901.4636291406615, 932.8787257656512, 14216.147031178136, 14258.287085645716, 14301.856981430183, 14303.856961430383, 14387.064840785355, 13782.310884455786, 13984.860151398483, 14004.0, 14028.298585070732, 14046.64883377916, 736.3851184261148, 745.6458182363389, 876.3296078499952, 878.4948654523643, 879.1164879296298, 879.7272845417909, 885.4687187687368, 887.0331338840663, 887.3344991256557, 890.973270801877, 923.1138107416888, 927.4667066436825, 928.767808047988, 928.7910220200469, 930.3998920696147, 921.387277460488, 923.2936803345447, 923.930705197113, 925.9259259259277, 940.6989763275755, 703.4934846910216, 705.2031204738613, 705.403933676048, 705.9611721355324, 706.6572712234562, 13204.207747535083, 13229.404676789567, 13276.269805160713, 13291.601251962456, 13308.334583270895, 13832.446702131903, 13934.58196254114, 14000.159990400507, 14100.153990760587, 14195.858041419557, 11580.884191158066, 11648.708782280426, 11707.239029463057, 11820.940895295469, 12133.635990920286, 3898.3567711327596, 3936.3270609990927, 3991.820368083443, 3993.6605388542007, 4059.2287465381482, 49273.50726492761, 49322.7533862332, 50047.49952500465, 50193.0, 50198.498015019744, 11001.669949901516, 11040.723981900355, 11083.889161108447, 11099.97618669634, 11226.158038147172, 19341.226350945806, 20134.0, 20136.295229666892, 20136.295229667183, 20193.0, 7479.289467500579, 7659.387249020065, 7714.166484510128, 7784.610769461504, 8151.918480815235, 4115.279826030433, 4205.201011807747, 4344.543822898613, 4572.565606267399, 4572.908541829145, 3321.036899299176, 3325.717314028335, 3328.7836290641517, 3335.299587086739, 3347.447671134284, 577.8584246859547, 596.3082823924227, 597.6563476001317, 600.8167508909737, 617.6541136963315, 627.9937200627935, 680.8093733754557, 689.6448329110513, 694.4305669351185, 710.4103594016954, 9792.608295668093, 9795.167410770164, 9862.260330475243, 9994.700158995242, 10181.767323839495, 620.9627422354673, 642.1170890026214, 673.6800019990466, 692.8995295682098, 699.4614147106699, 4478.955210447919, 4628.120657075145, 4633.884152896205, 4668.5564871337165, 4700.0, 61585.076223856675, 62115.0, 62296.37703622996, 62369.37630623636, 62436.687816560625, 55868.72065639646, 56236.71881640647, 57152.142717859264, 58635.12047319294, 58767.0, 50415.99168016619, 51232.48767512352, 51611.741941290806, 51629.741851290506, 52798.472015280124, 9280.860787088333, 9486.478243696663, 9519.28605354615, 9550.426974381558, 9621.134097931219, 36224.0, 37012.81493592515, 37294.627053730204, 37383.43924841075, 37599.496020158884, 44361.0, 44509.0, 46404.30393544167, 46755.76622116868, 49019.754901225264, 10904.018638322588, 11823.422601034055, 12098.274103553815, 12166.902517290275, 12206.633800985985, 13176.73646527045, 13209.801852972405, 13303.66740831487, 13705.520306789613, 13732.244726539737, 11403.828942566033, 11717.179797414441, 11809.291442513477, 12012.0, 12619.432125554189, 11963.0, 12058.75882482363, 12211.633650990485, 12219.266843989033, 12704.745905081661, 11908.76182476363, 11980.101492387932, 12750.234985900504, 13162.0, 13239.271840048505, 9751.171150452292, 9971.700848974542, 10070.0, 10530.842037369599, 10585.153187745116, 9949.651762188289, 10449.21630877672, 10458.947705261426, 10613.575456981944, 10685.305455145392], "unit": "score", "name": "yui.html", "value": 6808.403453382078}], "name": "dromaeo_css", "value": 7350.714971453883}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 105.0, 113.0, 110.0, 110.0, 120.0, 109.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 150.0, 169.0, 126.0, 156.0, 152.0, 133.0, 165.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 164.0, 165.0, 163.0, 165.0, 162.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 72.0, 161.0, 76.0, 73.0, 75.0, 76.0, 156.0, 73.0], "unit": "score", "name": "audio-fft", "value": 91.3}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 142.0, 94.0, 95.0, 95.0, 147.0, 95.0, 95.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 112.0, 114.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 149.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 59.0, 61.0, 58.0, 59.0, 59.0, 60.0, 58.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 79.0, 78.0, 79.0, 80.0, 79.0, 78.0, 79.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [114.0, 109.0, 117.0, 120.0, 115.0, 125.0, 110.0, 112.0, 116.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.0}, {"lowerIsBetter": true, "replicates": [133.0, 134.0, 133.0, 127.0, 133.0, 143.0, 120.0, 133.0, 146.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.1}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 72.0, 64.0, 65.0, 66.0, 64.0, 65.0, 63.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.4}], "name": "kraken", "value": 1492.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [166.58337497917708], "unit": "score", "name": "DeltaBlue", "value": 396.90635400000014}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [922.509225092251], "unit": "score", "name": "RayTrace", "value": 802.1480759999998}, {"lowerIsBetter": false, "replicates": [559.9104143337066], "unit": "score", "name": "Earley", "value": 1190.3029180000005}, {"lowerIsBetter": false, "replicates": [10891.304347826086], "unit": "score", "name": "Boyer", "value": 61.19221157684634}, {"lowerIsBetter": false, "replicates": [38634.61538461538], "unit": "score", "name": "RegExp", "value": 23.579502239920362}, {"lowerIsBetter": false, "replicates": [499.2511233150275], "unit": "score", "name": "Splay", "value": 163.226473}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 22267.940407240745}]} 12:38:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,43]]", "result": "22267.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,43]]", "result": "1492.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,43]]", "result": "7350.72"}}} 12:38:27 INFO - Return code: 0 12:38:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:38:27 INFO - # TBPL SUCCESS # 12:38:27 INFO - Running post-action listener: _resource_record_post_action 12:38:27 INFO - Running post-run listener: _resource_record_post_run 12:38:28 INFO - Total resource usage - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 470183936; Read time: 36; Write time: 499480 12:38:28 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 241958912; Read time: 0; Write time: 335880 12:38:28 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 8192; Write bytes: 228225024; Read time: 36; Write time: 163600 12:38:28 INFO - Running post-run listener: _upload_blobber_files 12:38:28 INFO - Blob upload gear active. 12:38:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:38:28 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 12:38:28 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', 'Date-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:38:28 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 Date-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:38:28 INFO - (blobuploader) - INFO - Open directory for files ... 12:38:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:38:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:38:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:29 INFO - (blobuploader) - INFO - Done attempting. 12:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:38:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:30 INFO - (blobuploader) - INFO - Done attempting. 12:38:30 INFO - (blobuploader) - INFO - Iteration through files over. 12:38:30 INFO - Return code: 0 12:38:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:38:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:38:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/0d35798256d64812db2af2631cf8a58ede55d07903969552175abf54b2d1c42f5b400f5469a3d5238eedc5f90c2c0950272ce4b298fafff64019753e5e11bbf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/2a9560e9bcb0fbf775a8b3428ee0552f02984895bfa582150ce4a7b0d2db6e4b6adfde8a641765041349b1d30dc2224b57610c90f76a591bfddb05a3ccc289e4"} 12:38:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:38:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:38:30 INFO - Contents: 12:38:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/0d35798256d64812db2af2631cf8a58ede55d07903969552175abf54b2d1c42f5b400f5469a3d5238eedc5f90c2c0950272ce4b298fafff64019753e5e11bbf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/2a9560e9bcb0fbf775a8b3428ee0552f02984895bfa582150ce4a7b0d2db6e4b6adfde8a641765041349b1d30dc2224b57610c90f76a591bfddb05a3ccc289e4"} 12:38:30 INFO - Running post-run listener: copy_logs_to_upload_dir 12:38:30 INFO - Copying logs to upload dir... 12:38:30 INFO - mkdir: /builds/slave/test/build/upload/logs 12:38:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.510232 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-03-11 12:38:29.672385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 12:38:29.676161) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 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/Date-Non-PGO/sha512/0d35798256d64812db2af2631cf8a58ede55d07903969552175abf54b2d1c42f5b400f5469a3d5238eedc5f90c2c0950272ce4b298fafff64019753e5e11bbf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/2a9560e9bcb0fbf775a8b3428ee0552f02984895bfa582150ce4a7b0d2db6e4b6adfde8a641765041349b1d30dc2224b57610c90f76a591bfddb05a3ccc289e4"} build_url:https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011460 build_url: 'https://queue.taskcluster.net/v1/task/ZkeTxXzFSsOSIeBCxfCe5Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/0d35798256d64812db2af2631cf8a58ede55d07903969552175abf54b2d1c42f5b400f5469a3d5238eedc5f90c2c0950272ce4b298fafff64019753e5e11bbf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/2a9560e9bcb0fbf775a8b3428ee0552f02984895bfa582150ce4a7b0d2db6e4b6adfde8a641765041349b1d30dc2224b57610c90f76a591bfddb05a3ccc289e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 12:38:29.703150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:38:29.703570) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1457727182.262205-1224175125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:38:29.790811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 12:38:29.791173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 12:38:29.791527) ========= ========= Total master_lag: 0.27 =========