builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1461303201.91 results: success (0) buildid: 20160421210502 builduid: 4af037259fc74061b246381ccbe2bf02 revision: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:21.913421) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:21.914058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:21.914392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:21.933105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:21.933479) ========= 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-1461298573.768321-1420507860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 22:33:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.0M=0s 2016-04-21 22:33:23 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.051646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.052033) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020881 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.101758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.102142) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f --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-1461298573.768321-1420507860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 22:33:23,775 truncating revision to first 12 chars 2016-04-21 22:33:23,775 Setting DEBUG logging. 2016-04-21 22:33:23,775 attempt 1/10 2016-04-21 22:33:23,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2271b0c11307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 22:33:24,041 unpacking tar archive at: fx-team-2271b0c11307/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560394 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.675951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.676354) ========= script_repo_revision: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.676818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.677160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 22:33:22.684658) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-21 22:33:22.684982) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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-1461298573.768321-1420507860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:33:24 INFO - MultiFileLogger online at 20160421 22:33:24 in /builds/slave/test 22:33:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:33:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:33:24 INFO - {'append_to_log': False, 22:33:24 INFO - 'base_work_dir': '/builds/slave/test', 22:33:24 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:33:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:33:24 INFO - 'branch': 'Fx-Team-Non-PGO', 22:33:24 INFO - 'buildbot_json_path': 'buildprops.json', 22:33:24 INFO - 'config_files': ('talos/linux_config.py',), 22:33:24 INFO - 'default_actions': ('clobber', 22:33:24 INFO - 'read-buildbot-config', 22:33:24 INFO - 'download-and-extract', 22:33:24 INFO - 'populate-webroot', 22:33:24 INFO - 'create-virtualenv', 22:33:24 INFO - 'install', 22:33:24 INFO - 'run-tests'), 22:33:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:33:24 INFO - 'download_minidump_stackwalk': True, 22:33:24 INFO - 'download_symbols': 'ondemand', 22:33:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:33:24 INFO - 'tooltool.py': '/tools/tooltool.py', 22:33:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:33:24 INFO - '/tools/misc-python/virtualenv.py')}, 22:33:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:33:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:33:24 INFO - 'installer_path': 'installer.exe', 22:33:24 INFO - 'log_level': 'info', 22:33:24 INFO - 'log_name': 'talos', 22:33:24 INFO - 'log_to_console': True, 22:33:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:33:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:33:24 INFO - 'opt_config_files': (), 22:33:24 INFO - 'pip_index': False, 22:33:24 INFO - 'sps_profile': False, 22:33:24 INFO - 'sps_profile_interval': 0, 22:33:24 INFO - 'suite': 'dromaeojs-e10s', 22:33:24 INFO - 'system_bits': '32', 22:33:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:33:24 INFO - 'title': 'talos-linux64-ix-067', 22:33:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:33:24 INFO - 'use_talos_json': True, 22:33:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:33:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:33:24 INFO - 'work_dir': 'build'} 22:33:24 INFO - ##### 22:33:24 INFO - ##### Running clobber step. 22:33:24 INFO - ##### 22:33:24 INFO - Running pre-action listener: _resource_record_pre_action 22:33:24 INFO - Running main action method: clobber 22:33:24 INFO - rmtree: /builds/slave/test/build 22:33:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:33:24 INFO - Running post-action listener: _resource_record_post_action 22:33:24 INFO - ##### 22:33:24 INFO - ##### Running read-buildbot-config step. 22:33:24 INFO - ##### 22:33:24 INFO - Running pre-action listener: _resource_record_pre_action 22:33:24 INFO - Running main action method: read_buildbot_config 22:33:24 INFO - Using buildbot properties: 22:33:24 INFO - { 22:33:24 INFO - "project": "", 22:33:24 INFO - "product": "firefox", 22:33:24 INFO - "script_repo_revision": "production", 22:33:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:33:24 INFO - "repository": "", 22:33:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:33:24 INFO - "buildid": "20160421210502", 22:33:24 INFO - "pgo_build": "False", 22:33:24 INFO - "basedir": "/builds/slave/test", 22:33:24 INFO - "buildnumber": 1183, 22:33:24 INFO - "slavename": "talos-linux64-ix-067", 22:33:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:33:24 INFO - "platform": "ubuntu64_hw", 22:33:24 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:33:24 INFO - "branch": "fx-team", 22:33:24 INFO - "repo_path": "integration/fx-team", 22:33:24 INFO - "revision": "2271b0c11307e6b780eb61d2c6dbae6ae9ed927f", 22:33:24 INFO - "stage_platform": "linux64", 22:33:24 INFO - "builduid": "4af037259fc74061b246381ccbe2bf02", 22:33:24 INFO - "slavebuilddir": "test" 22:33:24 INFO - } 22:33:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:33:24 INFO - Running post-action listener: _resource_record_post_action 22:33:24 INFO - ##### 22:33:24 INFO - ##### Running download-and-extract step. 22:33:24 INFO - ##### 22:33:24 INFO - Running pre-action listener: _resource_record_pre_action 22:33:24 INFO - Running main action method: download_and_extract 22:33:24 INFO - mkdir: /builds/slave/test/build/tests 22:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:24 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:33:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:33:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:33:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:33:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:33:26 INFO - Downloaded 1361 bytes. 22:33:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:33:26 INFO - Using the following test package requirements: 22:33:26 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:33:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:33:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:33:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:26 INFO - u'jsshell-linux-x86_64.zip'], 22:33:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:33:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:33:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:33:26 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:33:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:33:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:33:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:26 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:33:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:33:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:33:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:33:27 INFO - Downloaded 22281373 bytes. 22:33:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:33:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:33:28 INFO - Return code: 0 22:33:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:28 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:33:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:33:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:33:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:33:29 INFO - Downloaded 22281373 bytes. 22:33:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:33:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:33:30 INFO - Return code: 0 22:33:30 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')]} 22:33:30 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:33:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:33:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:33:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:33:32 INFO - Downloaded 10845952 bytes. 22:33:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:33:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:33:32 INFO - Return code: 0 22:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:32 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:33:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:33:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:33:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:33:34 INFO - Downloaded 54630132 bytes. 22:33:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:33:34 INFO - mkdir: /builds/slave/test/properties 22:33:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:33:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:33:34 INFO - Contents: 22:33:34 INFO - build_url:https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:33:35 INFO - Running post-action listener: _resource_record_post_action 22:33:35 INFO - Running post-action listener: set_extra_try_arguments 22:33:35 INFO - ##### 22:33:35 INFO - ##### Running populate-webroot step. 22:33:35 INFO - ##### 22:33:35 INFO - Running pre-action listener: _resource_record_pre_action 22:33:35 INFO - Running main action method: populate_webroot 22:33:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:33:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:33:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:33:35 INFO - '--tppagecycles', 22:33:35 INFO - '7'], 22:33:35 INFO - 'tests': ['tsvgm']}}, 22:33:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:33:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:33:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:33:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:33:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:33:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:33:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['damp', 'tps']}, 22:33:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'tests': ['damp', 'tps']}, 22:33:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['dromaeo_dom']}, 22:33:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:33:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other-e10s': {'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['tsvgx', 22:33:35 INFO - 'tsvgr_opacity', 22:33:35 INFO - 'tart', 22:33:35 INFO - 'tscrollx', 22:33:35 INFO - 'cart']}, 22:33:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:33:35 INFO - 'tsvgr_opacity', 22:33:35 INFO - 'tart', 22:33:35 INFO - 'tscrollx', 22:33:35 INFO - 'cart']}, 22:33:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['tp5o']}, 22:33:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'tests': ['tp5o']}, 22:33:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--disable-e10s', 22:33:35 INFO - '--xperf_path', 22:33:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:33:35 INFO - 'tests': ['tp5n']}, 22:33:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--xperf_path', 22:33:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:33:35 INFO - 'tests': ['tp5n']}}, 22:33:35 INFO - 'talos.zip': {'path': '', 22:33:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:33:35 INFO - Running post-action listener: _resource_record_post_action 22:33:35 INFO - ##### 22:33:35 INFO - ##### Running create-virtualenv step. 22:33:35 INFO - ##### 22:33:35 INFO - Running pre-action listener: _resource_record_pre_action 22:33:35 INFO - Running main action method: create_virtualenv 22:33:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:33:35 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 22:33:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:33:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:33:35 INFO - Using real prefix '/usr' 22:33:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:33:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:33:38 INFO - Installing pip.................done. 22:33:38 INFO - Return code: 0 22:33:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:33:38 INFO - Using env: {'DISPLAY': ':0', 22:33:38 INFO - 'HOME': '/home/cltbld', 22:33:38 INFO - 'LANG': 'en_US.UTF-8', 22:33:38 INFO - 'LANGUAGE': 'en_US:en', 22:33:38 INFO - 'LOGNAME': 'cltbld', 22:33:38 INFO - 'MAIL': '/var/mail/cltbld', 22:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:38 INFO - 'MOZ_NO_REMOTE': '1', 22:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:38 INFO - 'NO_EM_RESTART': '1', 22:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:38 INFO - 'PWD': '/builds/slave/test', 22:33:38 INFO - 'SHELL': '/bin/bash', 22:33:38 INFO - 'SHLVL': '1', 22:33:38 INFO - 'TERM': 'linux', 22:33:38 INFO - 'TMOUT': '86400', 22:33:38 INFO - 'USER': 'cltbld', 22:33:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:38 INFO - '_': '/tools/buildbot/bin/python'} 22:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:38 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 22:33:38 INFO - Cleaning up... 22:33:38 INFO - Return code: 0 22:33:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:33:38 INFO - Using env: {'DISPLAY': ':0', 22:33:38 INFO - 'HOME': '/home/cltbld', 22:33:38 INFO - 'LANG': 'en_US.UTF-8', 22:33:38 INFO - 'LANGUAGE': 'en_US:en', 22:33:38 INFO - 'LOGNAME': 'cltbld', 22:33:38 INFO - 'MAIL': '/var/mail/cltbld', 22:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:38 INFO - 'MOZ_NO_REMOTE': '1', 22:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:38 INFO - 'NO_EM_RESTART': '1', 22:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:38 INFO - 'PWD': '/builds/slave/test', 22:33:38 INFO - 'SHELL': '/bin/bash', 22:33:38 INFO - 'SHLVL': '1', 22:33:38 INFO - 'TERM': 'linux', 22:33:38 INFO - 'TMOUT': '86400', 22:33:38 INFO - 'USER': 'cltbld', 22:33:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:38 INFO - '_': '/tools/buildbot/bin/python'} 22:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:38 INFO - Downloading/unpacking psutil>=0.7.1 22:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:33:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:40 INFO - Installing collected packages: psutil 22:33:40 INFO - Running setup.py install for psutil 22:33:40 INFO - building 'psutil._psutil_linux' extension 22:33:40 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 22:33:40 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 22:33:40 INFO - building 'psutil._psutil_posix' extension 22:33:40 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 22:33:40 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 22:33:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:40 INFO - Successfully installed psutil 22:33:40 INFO - Cleaning up... 22:33:41 INFO - Return code: 0 22:33:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:33:41 INFO - Using env: {'DISPLAY': ':0', 22:33:41 INFO - 'HOME': '/home/cltbld', 22:33:41 INFO - 'LANG': 'en_US.UTF-8', 22:33:41 INFO - 'LANGUAGE': 'en_US:en', 22:33:41 INFO - 'LOGNAME': 'cltbld', 22:33:41 INFO - 'MAIL': '/var/mail/cltbld', 22:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:41 INFO - 'MOZ_NO_REMOTE': '1', 22:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:41 INFO - 'NO_EM_RESTART': '1', 22:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:41 INFO - 'PWD': '/builds/slave/test', 22:33:41 INFO - 'SHELL': '/bin/bash', 22:33:41 INFO - 'SHLVL': '1', 22:33:41 INFO - 'TERM': 'linux', 22:33:41 INFO - 'TMOUT': '86400', 22:33:41 INFO - 'USER': 'cltbld', 22:33:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:41 INFO - '_': '/tools/buildbot/bin/python'} 22:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:33:43 INFO - Installing collected packages: mozsystemmonitor 22:33:43 INFO - Running setup.py install for mozsystemmonitor 22:33:43 INFO - Successfully installed mozsystemmonitor 22:33:43 INFO - Cleaning up... 22:33:43 INFO - Return code: 0 22:33:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:43 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 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:43 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 22:33:43 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 22:33:43 INFO - Using env: {'DISPLAY': ':0', 22:33:43 INFO - 'HOME': '/home/cltbld', 22:33:43 INFO - 'LANG': 'en_US.UTF-8', 22:33:43 INFO - 'LANGUAGE': 'en_US:en', 22:33:43 INFO - 'LOGNAME': 'cltbld', 22:33:43 INFO - 'MAIL': '/var/mail/cltbld', 22:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:43 INFO - 'MOZ_NO_REMOTE': '1', 22:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:43 INFO - 'NO_EM_RESTART': '1', 22:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:43 INFO - 'PWD': '/builds/slave/test', 22:33:43 INFO - 'SHELL': '/bin/bash', 22:33:43 INFO - 'SHLVL': '1', 22:33:43 INFO - 'TERM': 'linux', 22:33:43 INFO - 'TMOUT': '86400', 22:33:43 INFO - 'USER': 'cltbld', 22:33:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:43 INFO - '_': '/tools/buildbot/bin/python'} 22:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:33:43 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 22:33:43 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 22:33:43 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 22:33:43 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 22:33:43 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 22:33:43 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 22:33:45 INFO - Downloading blobuploader-1.2.4.tar.gz 22:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:33:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:33:45 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 22:33:45 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 22:33:45 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 22:33:45 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 22:33:45 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 22:33:45 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 22:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:33:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:33:45 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 22:33:45 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 22:33:45 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 22:33:45 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 22:33:45 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 22:33:45 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 22:33:46 INFO - Downloading docopt-0.6.1.tar.gz 22:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:33:46 INFO - Installing collected packages: blobuploader, requests, docopt 22:33:46 INFO - Running setup.py install for blobuploader 22:33:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:33:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:33:46 INFO - Running setup.py install for requests 22:33:46 INFO - Running setup.py install for docopt 22:33:46 INFO - Successfully installed blobuploader requests docopt 22:33:46 INFO - Cleaning up... 22:33:46 INFO - Return code: 0 22:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:46 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 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:46 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 22:33:46 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 22:33:46 INFO - Using env: {'DISPLAY': ':0', 22:33:46 INFO - 'HOME': '/home/cltbld', 22:33:46 INFO - 'LANG': 'en_US.UTF-8', 22:33:46 INFO - 'LANGUAGE': 'en_US:en', 22:33:46 INFO - 'LOGNAME': 'cltbld', 22:33:46 INFO - 'MAIL': '/var/mail/cltbld', 22:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:46 INFO - 'MOZ_NO_REMOTE': '1', 22:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:46 INFO - 'NO_EM_RESTART': '1', 22:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:46 INFO - 'PWD': '/builds/slave/test', 22:33:46 INFO - 'SHELL': '/bin/bash', 22:33:46 INFO - 'SHLVL': '1', 22:33:46 INFO - 'TERM': 'linux', 22:33:46 INFO - 'TMOUT': '86400', 22:33:46 INFO - 'USER': 'cltbld', 22:33:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:46 INFO - '_': '/tools/buildbot/bin/python'} 22:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:46 INFO - Running setup.py (path:/tmp/pip-Fkrhgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:47 INFO - Running setup.py (path:/tmp/pip-kBJTJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:47 INFO - Running setup.py (path:/tmp/pip-ieSixm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:47 INFO - Running setup.py (path:/tmp/pip-hGT_4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:47 INFO - Running setup.py (path:/tmp/pip-Hn6RGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:47 INFO - Running setup.py (path:/tmp/pip-gufQfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:47 INFO - Running setup.py (path:/tmp/pip-yzfV7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:47 INFO - Running setup.py (path:/tmp/pip-753e16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:47 INFO - Running setup.py (path:/tmp/pip-iknOPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:47 INFO - Running setup.py (path:/tmp/pip-3Rpulv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:47 INFO - Running setup.py (path:/tmp/pip-0g3T7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:47 INFO - Running setup.py (path:/tmp/pip-mPist0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:47 INFO - Running setup.py (path:/tmp/pip-xASuIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:47 INFO - Running setup.py (path:/tmp/pip-zyp0of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:47 INFO - Running setup.py (path:/tmp/pip-iym08b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:48 INFO - Running setup.py (path:/tmp/pip-bhm6Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:48 INFO - Running setup.py (path:/tmp/pip-cH6oLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:33:48 INFO - Running setup.py install for manifestparser 22:33:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Running setup.py install for mozcrash 22:33:48 INFO - Running setup.py install for mozdebug 22:33:48 INFO - Running setup.py install for mozdevice 22:33:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Running setup.py install for mozfile 22:33:48 INFO - Running setup.py install for mozhttpd 22:33:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Running setup.py install for mozinfo 22:33:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Running setup.py install for mozInstall 22:33:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:33:48 INFO - Running setup.py install for mozleak 22:33:49 INFO - Running setup.py install for mozlog 22:33:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for moznetwork 22:33:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for mozprocess 22:33:49 INFO - Running setup.py install for mozprofile 22:33:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for mozrunner 22:33:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for mozscreenshot 22:33:49 INFO - Running setup.py install for moztest 22:33:49 INFO - Running setup.py install for mozversion 22:33:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:33:49 INFO - Cleaning up... 22:33:49 INFO - Return code: 0 22:33:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:49 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 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:49 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 22:33:49 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 22:33:49 INFO - Using env: {'DISPLAY': ':0', 22:33:49 INFO - 'HOME': '/home/cltbld', 22:33:49 INFO - 'LANG': 'en_US.UTF-8', 22:33:49 INFO - 'LANGUAGE': 'en_US:en', 22:33:49 INFO - 'LOGNAME': 'cltbld', 22:33:49 INFO - 'MAIL': '/var/mail/cltbld', 22:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:49 INFO - 'MOZ_NO_REMOTE': '1', 22:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:49 INFO - 'NO_EM_RESTART': '1', 22:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:49 INFO - 'PWD': '/builds/slave/test', 22:33:49 INFO - 'SHELL': '/bin/bash', 22:33:49 INFO - 'SHLVL': '1', 22:33:49 INFO - 'TERM': 'linux', 22:33:49 INFO - 'TMOUT': '86400', 22:33:49 INFO - 'USER': 'cltbld', 22:33:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:49 INFO - '_': '/tools/buildbot/bin/python'} 22:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:50 INFO - Running setup.py (path:/tmp/pip-kJHc4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:50 INFO - Running setup.py (path:/tmp/pip-KEPial-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:50 INFO - Running setup.py (path:/tmp/pip-itXWJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:50 INFO - Running setup.py (path:/tmp/pip-aNuD6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:50 INFO - Running setup.py (path:/tmp/pip-vIKqzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:50 INFO - Running setup.py (path:/tmp/pip-pInyVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:50 INFO - Running setup.py (path:/tmp/pip-HthH97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:50 INFO - Running setup.py (path:/tmp/pip-vemEE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:50 INFO - Running setup.py (path:/tmp/pip-NMnqI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:50 INFO - Running setup.py (path:/tmp/pip-dRvkkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:50 INFO - Running setup.py (path:/tmp/pip-6cxhwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:50 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)) 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:50 INFO - Running setup.py (path:/tmp/pip-t1n4zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:51 INFO - Running setup.py (path:/tmp/pip-3oo0Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:51 INFO - Running setup.py (path:/tmp/pip-8j2eB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:51 INFO - Running setup.py (path:/tmp/pip-VE9ox3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:51 INFO - Running setup.py (path:/tmp/pip-l3BHBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:51 INFO - Running setup.py (path:/tmp/pip-Pehw_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:51 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)) 22:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:33:51 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)) 22:33:51 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)) 22:33:51 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)) 22:33:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:53 INFO - Downloading blessings-1.6.tar.gz 22:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:33:53 INFO - Installing collected packages: blessings 22:33:53 INFO - Running setup.py install for blessings 22:33:53 INFO - Successfully installed blessings 22:33:53 INFO - Cleaning up... 22:33:53 INFO - Return code: 0 22:33:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:53 INFO - Reading from file tmpfile_stdout 22:33:53 INFO - Current package versions: 22:33:53 INFO - argparse == 1.2.1 22:33:53 INFO - blessings == 1.6 22:33:53 INFO - blobuploader == 1.2.4 22:33:53 INFO - docopt == 0.6.1 22:33:53 INFO - manifestparser == 1.1 22:33:53 INFO - mozInstall == 1.12 22:33:53 INFO - mozcrash == 0.17 22:33:53 INFO - mozdebug == 0.1 22:33:53 INFO - mozdevice == 0.48 22:33:53 INFO - mozfile == 1.2 22:33:53 INFO - mozhttpd == 0.7 22:33:53 INFO - mozinfo == 0.9 22:33:53 INFO - mozleak == 0.1 22:33:53 INFO - mozlog == 3.1 22:33:53 INFO - moznetwork == 0.27 22:33:53 INFO - mozprocess == 0.22 22:33:53 INFO - mozprofile == 0.28 22:33:53 INFO - mozrunner == 6.11 22:33:53 INFO - mozscreenshot == 0.1 22:33:53 INFO - mozsystemmonitor == 0.0 22:33:53 INFO - moztest == 0.7 22:33:53 INFO - mozversion == 1.4 22:33:53 INFO - psutil == 3.1.1 22:33:53 INFO - requests == 1.2.3 22:33:53 INFO - wsgiref == 0.1.2 22:33:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:53 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 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:53 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 22:33:53 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 22:33:53 INFO - Using env: {'DISPLAY': ':0', 22:33:53 INFO - 'HOME': '/home/cltbld', 22:33:53 INFO - 'LANG': 'en_US.UTF-8', 22:33:53 INFO - 'LANGUAGE': 'en_US:en', 22:33:53 INFO - 'LOGNAME': 'cltbld', 22:33:53 INFO - 'MAIL': '/var/mail/cltbld', 22:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:53 INFO - 'MOZ_NO_REMOTE': '1', 22:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:53 INFO - 'NO_EM_RESTART': '1', 22:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:53 INFO - 'PWD': '/builds/slave/test', 22:33:53 INFO - 'SHELL': '/bin/bash', 22:33:53 INFO - 'SHLVL': '1', 22:33:53 INFO - 'TERM': 'linux', 22:33:53 INFO - 'TMOUT': '86400', 22:33:53 INFO - 'USER': 'cltbld', 22:33:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:53 INFO - '_': '/tools/buildbot/bin/python'} 22:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 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)) 22:33:53 INFO - Cleaning up... 22:33:53 INFO - Return code: 0 22:33:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:53 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 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:53 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 22:33:53 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 22:33:53 INFO - Using env: {'DISPLAY': ':0', 22:33:53 INFO - 'HOME': '/home/cltbld', 22:33:53 INFO - 'LANG': 'en_US.UTF-8', 22:33:53 INFO - 'LANGUAGE': 'en_US:en', 22:33:53 INFO - 'LOGNAME': 'cltbld', 22:33:53 INFO - 'MAIL': '/var/mail/cltbld', 22:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:53 INFO - 'MOZ_NO_REMOTE': '1', 22:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:53 INFO - 'NO_EM_RESTART': '1', 22:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:53 INFO - 'PWD': '/builds/slave/test', 22:33:53 INFO - 'SHELL': '/bin/bash', 22:33:53 INFO - 'SHLVL': '1', 22:33:53 INFO - 'TERM': 'linux', 22:33:53 INFO - 'TMOUT': '86400', 22:33:53 INFO - 'USER': 'cltbld', 22:33:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:53 INFO - '_': '/tools/buildbot/bin/python'} 22:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:54 INFO - Downloading/unpacking jsonschema 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:33:56 INFO - Downloading/unpacking functools32 (from jsonschema) 22:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:56 INFO - Downloading functools32-3.2.3-2.tar.gz 22:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:33:56 INFO - warning: no files found matching '*.txt' 22:33:56 INFO - no previously-included directories found matching 'build' 22:33:56 INFO - no previously-included directories found matching 'dist' 22:33:56 INFO - no previously-included directories found matching '.git*' 22:33:56 INFO - Installing collected packages: jsonschema, functools32 22:33:56 INFO - Running setup.py install for functools32 22:33:56 INFO - warning: no files found matching '*.txt' 22:33:56 INFO - no previously-included directories found matching 'build' 22:33:56 INFO - no previously-included directories found matching 'dist' 22:33:56 INFO - no previously-included directories found matching '.git*' 22:33:56 INFO - Successfully installed jsonschema functools32 22:33:56 INFO - Cleaning up... 22:33:56 INFO - Return code: 0 22:33:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc133072f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, '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-1461298573.768321-1420507860', '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 22:33:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:33:56 INFO - Using env: {'DISPLAY': ':0', 22:33:56 INFO - 'HOME': '/home/cltbld', 22:33:56 INFO - 'LANG': 'en_US.UTF-8', 22:33:56 INFO - 'LANGUAGE': 'en_US:en', 22:33:56 INFO - 'LOGNAME': 'cltbld', 22:33:56 INFO - 'MAIL': '/var/mail/cltbld', 22:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:56 INFO - 'MOZ_NO_REMOTE': '1', 22:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:56 INFO - 'NO_EM_RESTART': '1', 22:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:56 INFO - 'PWD': '/builds/slave/test', 22:33:56 INFO - 'SHELL': '/bin/bash', 22:33:56 INFO - 'SHLVL': '1', 22:33:56 INFO - 'TERM': 'linux', 22:33:56 INFO - 'TMOUT': '86400', 22:33:56 INFO - 'USER': 'cltbld', 22:33:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:56 INFO - '_': '/tools/buildbot/bin/python'} 22:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:56 INFO - Downloading/unpacking flake8 22:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:33:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:33:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:33:59 INFO - no previously-included directories found matching 'docs/_build' 22:33:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:33:59 INFO - Running setup.py install for pep8 22:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:33:59 INFO - no previously-included directories found matching 'docs/_build' 22:33:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:33:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:33:59 INFO - Cleaning up... 22:33:59 INFO - Return code: 0 22:33:59 INFO - Running post-action listener: _resource_record_post_action 22:33:59 INFO - Running post-action listener: _start_resource_monitoring 22:33:59 INFO - Starting resource monitoring. 22:33:59 INFO - ##### 22:33:59 INFO - ##### Running install step. 22:33:59 INFO - ##### 22:33:59 INFO - Running pre-action listener: _resource_record_pre_action 22:33:59 INFO - Running main action method: install 22:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:59 INFO - Reading from file tmpfile_stdout 22:33:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:33:59 INFO - Reading from file tmpfile_stdout 22:33:59 INFO - Output received: 22:33:59 INFO - Usage: mozinstall [options] installer 22:33:59 INFO - Options: 22:33:59 INFO - -h, --help show this help message and exit 22:33:59 INFO - -d DEST, --destination=DEST 22:33:59 INFO - Directory to install application into. [default: 22:33:59 INFO - "/builds/slave/test"] 22:33:59 INFO - --app=APP Application being installed. [default: firefox] 22:33:59 INFO - mkdir: /builds/slave/test/build/application 22:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:34:15 INFO - Reading from file tmpfile_stdout 22:34:15 INFO - Output received: 22:34:15 INFO - /builds/slave/test/build/application/firefox/firefox 22:34:15 INFO - Running post-action listener: _resource_record_post_action 22:34:15 INFO - ##### 22:34:15 INFO - ##### Running run-tests step. 22:34:15 INFO - ##### 22:34:15 INFO - Running pre-action listener: _resource_record_pre_action 22:34:15 INFO - Running main action method: run_tests 22:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:34:15 INFO - Python 2.7.3 22:34:15 INFO - Return code: 0 22:34:15 INFO - grabbing minidump binary from tooltool 22:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:15 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 0x2839410>, '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 0x283a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:34:15 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 22:34:15 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 22:34:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:34:15 INFO - Return code: 0 22:34:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:34:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:34:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:34:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:34:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:34:16 INFO - Return code: 0 22:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.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 22:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.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 22:34:16 INFO - Using env: {'DISPLAY': ':0', 22:34:16 INFO - 'HOME': '/home/cltbld', 22:34:16 INFO - 'LANG': 'en_US.UTF-8', 22:34:16 INFO - 'LANGUAGE': 'en_US:en', 22:34:16 INFO - 'LOGNAME': 'cltbld', 22:34:16 INFO - 'MAIL': '/var/mail/cltbld', 22:34:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:34:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:34:16 INFO - 'MOZ_NO_REMOTE': '1', 22:34:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:34:16 INFO - 'NO_EM_RESTART': '1', 22:34:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:34:16 INFO - 'PWD': '/builds/slave/test', 22:34:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:34:16 INFO - 'SHELL': '/bin/bash', 22:34:16 INFO - 'SHLVL': '1', 22:34:16 INFO - 'TERM': 'linux', 22:34:16 INFO - 'TMOUT': '86400', 22:34:16 INFO - 'USER': 'cltbld', 22:34:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461298573.768321-1420507860', 22:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:34:16 INFO - '_': '/tools/buildbot/bin/python'} 22:34:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.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 22:34:16 INFO - mozversion application_buildid: 20160421210502 22:34:16 INFO - mozversion application_changeset: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f 22:34:16 INFO - mozversion application_display_name: Nightly 22:34:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:34:16 INFO - mozversion application_name: Firefox 22:34:16 INFO - mozversion application_remotingname: firefox 22:34:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:34:16 INFO - mozversion application_vendor: Mozilla 22:34:16 INFO - mozversion application_version: 48.0a1 22:34:16 INFO - mozversion platform_buildid: 20160421210502 22:34:16 INFO - mozversion platform_changeset: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f 22:34:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:34:16 INFO - mozversion platform_version: 48.0a1 22:34:16 INFO - using testdate: 1461303256 22:34:16 INFO - actual date: 1461303256 22:34:16 INFO - starting webserver on 'localhost:32814' 22:34:16 INFO - SUITE-START | Running 2 tests 22:34:16 INFO - TEST-START | dromaeo_css 22:34:16 INFO - operating with platform_type : linux_ 22:34:16 INFO - Initialising browser for dromaeo_css test... 22:34:16 INFO - TEST-INFO | started process 18527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9PYzl8/profile http://localhost:32814/getInfo.html) 22:34:20 INFO - PROCESS | 18527 | 22:34:20 INFO - PROCESS | 18527 | (process:18595): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:34:21 INFO - PROCESS | 18527 | __metrics Screen width/height:1600/1200 22:34:21 INFO - PROCESS | 18527 | colorDepth:24 22:34:21 INFO - PROCESS | 18527 | Browser inner width/height: 1024/697 22:34:21 INFO - PROCESS | 18527 | __metrics 22:34:21 ERROR - PROCESS | 18527 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:34:22 INFO - TEST-INFO | 18527: exit 0 22:34:22 INFO - Browser initialized. 22:34:22 INFO - Running cycle 1/1 for dromaeo_css test... 22:34:22 INFO - TEST-INFO | started process 18646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9PYzl8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:24 INFO - PROCESS | 18646 | 22:34:24 INFO - PROCESS | 18646 | (process:18707): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:34:34 INFO - PROCESS | 18646 | RSS: Main: 165089280 22:34:34 INFO - PROCESS | 18646 | 22:35:24 INFO - PROCESS | 18646 | 1461303324261 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] 22:37:35 INFO - PROCESS | 18646 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32814/tests/dromaeo/cssquery-ext.html) 22:37:36 INFO - PROCESS | 18646 | RSS: Main: 169512960 22:37:36 INFO - PROCESS | 18646 | 22:40:38 INFO - PROCESS | 18646 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-ext.html (next: http://localhost:32814/tests/dromaeo/cssquery-jquery.html) 22:40:39 INFO - PROCESS | 18646 | RSS: Main: 165822464 22:40:39 INFO - PROCESS | 18646 | 22:43:41 INFO - PROCESS | 18646 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32814/tests/dromaeo/cssquery-mootools.html) 22:43:42 INFO - PROCESS | 18646 | RSS: Main: 167186432 22:43:42 INFO - PROCESS | 18646 | 22:46:43 INFO - PROCESS | 18646 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32814/tests/dromaeo/cssquery-prototype.html) 22:46:44 INFO - PROCESS | 18646 | RSS: Main: 164593664 22:46:44 INFO - PROCESS | 18646 | 22:49:47 INFO - PROCESS | 18646 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32814/tests/dromaeo/cssquery-yui.html) 22:49:47 INFO - PROCESS | 18646 | RSS: Main: 166002688 22:49:47 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | Cycle 1(1): loaded http://localhost:32814/tests/dromaeo/cssquery-yui.html (next: http://localhost:32814/tests/dromaeo/cssquery-dojo.html) 22:52:50 INFO - PROCESS | 18646 | RSS: Main: 168001536 22:52:50 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | __start_tp_report 22:52:50 INFO - PROCESS | 18646 | _x_x_mozilla_page_load 22:52:50 INFO - PROCESS | 18646 | _x_x_mozilla_page_load_details 22:52:50 INFO - PROCESS | 18646 | |i|pagename|runs| 22:52:50 INFO - PROCESS | 18646 | |0;dojo.html;2626.4878348722;2704.2968828104695;2716.1851444566623;2733.685626152993;2736.507428662841;4663.440387153542;4703.670743047984;4706.247000479924;4726.881827954303;4781.545753153454;4642.257238841786;4762.547557981986;4769.761511924398;4820.0600882827775;4849.515048495149;4361.672874534399;4442.933355999663;4446.933296000562;4447.4218351614245;4447.755373454459;583.7650988765697;4323.567643235667;4411.536788637195;4423.402840616508;4476.060027394251;4419.911601767979;4422.84520041797;4435.889102772457;4437.334399840018;4441.75570343631;4393.626541743955;4491.6855820092605;4495.033567782943;4498.955010449919;4509.4814096379005;4345.304751239818;4382.693211475198;4423.712458690175;4437.667174961858;4462.509123996358;4669.626429885635;4670.5329467053025;4716.38686970695;4721.976390118062;4788.80844766209;4991.825286114969;5073.568746656539;5135.3837539495125;5206.817761378334;5223.71269580173;5140.074786538422;5168.198929165986;5193.324867767204;5210.114280572274;5223.425423203445;4824.734639594786;4826.32431459596;4829.492903245108;4830.758462076882;4872.634552408584;5182.766775495112;5259.631825772236;5321.228421878806;5335.039692855245;5361.303030606075;5059.974700126476;5060.1903695408555;5074.340335756328;5083.898322033612;5114.130597798308;5173.275741396207;5178.637495375363;5194.740262986911;5202.1416466282635;5210.739463026834;5024.196128619404;5051.4695956924725;5084.542391184811;5092.388913330424;5135.897282054338;4945.085159245551;5108.259302401131;5119.948800512022;5127.46161653021;5151.665141765773;4295.634871035934;4316.913661726748;4318.114786468766;4320.827166913351;4359.041010977643;3695.0762309422644;3720.088578298334;3758.7180961428003;3767.5102236709054;3810.466534685146;4395.406620106309;4397.450318710161;4400.69195156336;4444.666650001198;4460.576245256695;5019.799208031711;5057.468965758542;5079.339685840817;5099.898002039939;5105.412877519058;4428.357888106207;4481.887952801206;4492;4525.321201819754;4527.253003254492;4626.259798432235;4635.907281854344;4638.165130276582;4665.5567721066445;4712.175369310357;4671.3927189464475;4850.587700045536;4889.48660390661;4892.559669629751;4899.853004409873;5142.742862856917;5147.279380886604;5194;5199.4020687621405;5218.26944227816;4802.6638135330195;4831.589314908272;4838.540338667821;4855.6601037927;4895.951040489549;4977.054359671651;5030.245463180552;5067.113255180255;5105.668131571436;5130.58955283569;5169.612279079009;5205.557527610044;5211.218317252443;5221.817236396708;5232.03207406631;5077.416097148875;5080.339555857715;5082.669626474268;5094.617903657315;5098.668586541863;4897.853064408074;4912.066707325596;4938.506149385033;4947.727874966768;4949.232868905326;4824.662273640952;4847.587955023721;4872.074305881871;4895.632827537877;4975.875603109951;5021.347224860745;5038.647294689336;5053.31780209667;5067.2652465391575;5116.053530096795;4803.855884323476;4946.431160416598;4969.130402179677;4991.126552853309;5024.924626130538 22:52:50 INFO - PROCESS | 18646 | |1;ext.html;567.3333832746524;586.1617886422417;599.4095815621613;613.9355367686394;630.1902055858218;33615;34650.826745866296;34817.129571760684;34850.82574587123;34928.476072858924;37545.62454375455;38096.80951595238;38342.61657383425;38410;38548.80725596375;7611.809704757384;7749.070111586618;7780.14418413974;7805.492642978216;7806.5316081035035;7620.885686714703;7670.463067585271;7716.768496945073;7722.61386930654;7739.845203095934;7643.197464266255;7690.692372305129;7714.421418393643;7721.652525636332;7780.494267872598;7649.1585925548425;7657.4639775215755;7723.995880535523;7733.226677332278;7744.922550774533;7605.277498637621;7690.884636730453;7694.730684426074;7705.961470192669;7706.344960678349;29658.40683186324;35704.28591428183;36083.09792255188;36108.45837312443;36261.27477450436;2573.5238980788426;2699.284689557269;2803.5487206891676;2843.8009339346254;3358.227607650254;24485.26544203677;25851;28408.28979275514;29572.26069348262;29606.555901661493;3359.0930448778936;3384.424647809878;3402.8638854445794;3413.9317213655586;3442.535257740198;170438;172399;172494.1375293128;173510;173898;48004.75997620059;48464;48520.7573962135;48571;48577.51422485801;58567;60841;60927;60965.39034609686;61137.38862611317;13286.53497127596;13432.328383580782;13505.729885402434;13520.79718804199;13526.25605591702;9823.901760982299;9907.554160062815;9939.950300248453;9948;9963.352382095141;17766.822331776515;17922.641547168983;18019.918804871748;18432.539186520175;18617.348392806456;6805.183377994574;6950.6177160256675;7023.122109736283;7073.398761105261;7111.502194846415;815.5269943432795;839.5760141128691;952.2334520710756;1023.1712313026472;1068.257560995101;26268.343291417867;28003.71996280052;28166.29584260369;28353;28538.286542836595;958.5399008475971;982.9361091529028;1007.2747621712356;1008.1027885182194;1054.7784965157402;12938.482460701654;13453.327333633279;13500.459981600823;13676.42721087068;13696.726065478833;346292;348248;352501;353196;353303;47118.76440617775;48178;48242.5175748238;48481.757591212525;48542;1226.3439060102803;1227.8526576810661;1232.969175770595;1254.0469243374919;1257.1891130220956;25626.743732562434;26214.213573592824;26270;26583;26995.190144295702;40990.38514422346;41912.80871912785;42161.789191053846;42246.78876605597;42261.57738422576;319311;321538;321788;321894;322167;25406.364840879127;25647.487050259264;25720.485590287713;25769;38201.42697859479;36066.27867442584;36109.63890361063;36420.27159456743;36662.450063248536;40399.7980010098;33941.49087763735;33997;34254.31491370109;34474;34543.654563454045;33231.667683322856;34225.65774342225;34359.65640343565;34397.484037738956;34601;34339.484907725906;34803.303933921685;34849.82575087108;35208.823955880056;35425.468617971266;30452.543211851396;31294.37411251808;31592.526112108797;31632.841835790674;31698.207544811565;23929.52140957206;24081;24188.39529011789;24439.38901527476;24766.133185338425 22:52:50 INFO - PROCESS | 18646 | |2;jquery.html;380.568055257283;383.6738772043763;383.9001859516525;387.7964068863847;392.59366555614946;15582.630863527493;16232.675346493077;16800;16838.41065562704;16905.154742262897;15552.377904883819;16080.75878861815;16868.493945181664;16881.577960550992;16917.7462338065;5164;5290.894182116355;5334.466553344654;5335.653182543142;5341.866453338659;3758.267137908109;5783.826485205451;6158.168647232634;6168.383161683818;6177.691115444232;5037.370328708911;6085.574009819315;6088.117223002662;6098.512119030467;6111.541634377417;5267.683938963655;5280.630355875091;5305.44292849253;5307.73461326934;5310.07073762092;5076.314697515825;5187.507186817246;5304.893902121975;5332.546733527654;5354.839354819362;11614.535418583246;11823.467943942544;12006.63980080599;12011.519539218421;12541.184822986568;1807.3945228348387;1981.7919118492496;1983.7520309961255;2052.8049835265624;2269.262489690857;8208.343332533383;8980.326475514363;9253.861192082124;9370.718878433658;11050.944745276222;1716.1419290354822;1721.6571074561737;1768.8761786674938;1781.2429717370067;1785.4643606917873;61745;65628;66769;67229.66385168042;69583.65208173927;10050.949745251228;10259.487025648688;10358.637447689294;10400.947995260127;10515.894841051644;14271;14313.21277329736;14435.206063666388;14497.492587759378;14505.274736263356;6805.557638753465;6808.965955170292;6887.690053947585;6936.583804971718;7023.262557431396;6186.628802271878;6264.310925798159;6327.082573026885;6400.7119679614525;6437.517186210959;4400.405945197357;4408.118376324684;4439.7336159829865;4459.397981272552;4468.642508599304;1717.7337512685554;1740.1821144062271;1825.5344887053982;1856.4337876947661;1883.5667796406904;871.2986046232717;895.6954635423987;899.5637115998735;904.6788390121412;915.0940568836803;15821;16273.51179464618;16344.591385215226;16505.6698866022;16604.6679066418;868.2880038368477;878.3149143667949;893.821235752852;919.8574220995756;958.8609651600478;9087.954560227157;9244.214241789523;9255.67605133817;9303.58133883977;9473.952630236943;405132;410075;412284;415549;417435;69328.65335673289;81431;81457;81572.59213704012;82009;908.909109089099;920.7836158502613;945.0455040409237;946.4368700623256;946.6024269806697;14326.212058336892;14468.565943021726;14538.127712337293;14577.562673119823;14821.25893705332;34027.65972340245;34848;34895.30209395849;35290.82354588313;36162.4575631371;45397.31904021509;48986.75506622444;49554.25668614901;49713.751431242614;49776;7212.459065570209;7994.1606131355375;8053.959730201312;8083.9191608083165;8196.303314218358;9974;11501.424928753697;11580.36308003068;11664.533418663159;11778.646640600795;8304.460210086567;9844.114029737359;9848.458334791656;9932.304738668225;10075.244356673133;9977.900220997697;10170.389776613427;10230.181585473294;10371.222158338003;10693;5778.8266352009505;8335.874961875455;9976.800463990825;10290.691279261635;10501.212409069503;7860.489068210548;7876.330511906552;7923.7226697065325;7997.880031799411;8043.356531477585;9716;9978.950105249718;10178.083972442515;10223.693289201336;10239.334443261165 22:52:50 INFO - PROCESS | 18646 | |3;mootools.html;1367.2480135925239;1431.6778724786925;1553.914534700591;1724.0862342958237;1732.4889157698478;6990.930090699091;7323.560586364822;7565;7601.049868766404;7645.770626881189;7810.258025487584;7864.410169237316;7933;7936.44444888858;7946.4834785738885;2296.391456264091;2330.463993281546;2331.6968794056834;2331.80179684727;2333.9299821005397;2236.552689462114;2287.622542280522;2297.322289924468;2304.493011537459;2306.8039216666602;2281.589313923493;2294;2302.033146078651;2322.082777302964;2335.019291897407;2227.9888600556974;2229.598672238996;2231.2190733243397;2239.9104035838545;2252.3468194223656;2222.533268013719;2230.130249202812;2238.675392068141;2247.955040899189;2248.7976082152522;7872.448928575002;7913.604319784045;7918.80202994924;7919.841603167904;7927.920720792834;4547.795349209294;4658.18481765693;4668.463126740435;4671.556202160789;4676;2889.6965818588956;2964.9110526684235;2972.2420782700488;2989.491786396296;3030.4545181867256;986.8223719730446;986.8667729856521;992.7964767222775;997.9051990060933;1013.6350913671073;10720.51757670899;10833.620823271227;10843.349399036084;10856.3486190828;10864;4311.051568654891;4331.523532411432;4470.530594287618;4494.438195225597;4496.3705081288645;9066.909330906607;9097.1812536872;9104.817903642022;9121.36150469474;9122.407043542149;4865.0756356292195;4870.4155501340065;4876.366072410564;4882.511748825089;4891.63312751538;3725.2177042820767;4144.129732756095;4282.293421585466;4287.206866729665;4432.15789000089;3616.692581130581;3694.261147770403;3755.1550901047594;3773.867914622975;3805.82873770681;1194.1223200947297;1257.9182353147016;1273.4587800184884;1282.602393258093;1285.0041218055894;752.8531936272484;783.8314762326128;794.3724457678485;807.5316316536395;823.8640624297044;5152.407473140562;5351;5359.088954877602;5390.51485366311;5399.622026458189;432.61929502038635;433.8329743048949;437.24138619495153;440.3109134204959;450.69803231834095;3416.8804091857164;3469.080693616194;3469.583649962021;3513.1217195701074;3518.313928783914;9334.859977100348;9811.558479868423;9868.062534059252;9871.901280987242;9900.455474948947;9609.615615375447;9691.12779849817;9737.123658870736;9770.413775173512;9810.215182785503;7392.334689877829;7455.925440745632;7473.813154671177;7473.887891681629;7492.438067144986;5155.896882062413;5156.845294641167;5164.845054648366;5406.21609866575;5414.945850541601;8721.563921803758;8784.516851573226;8829.69096081634;8855.468671879707;8946.463212207289;8781.648734050821;8888.333374996771;8958.3427065993;9011.729648110568;9127.863082053642;6614.140161778938;7094.751683691253;7228;7346.706131754884;7363.705451781869;7548.698052078075;7624.237576242332;7632.3512501438;7657.961710191414;7674.846503070019;6658.1011563438315;6810.863782724218;6812.182538095461;6944.826379340557;6957.826054348682;6557.147570815763;6617.636030018202;6631.33686631333;6645.634490102897;6717.731290748511;6115.1438798569125;6115.480184184216;6206.503479721521;6244.1570387997035;6259.96870015647;4535.727856328631;4584.793684284282;4591.242444996538;4605.37827393311;4652.697574657636;4497.123061003073;4563.292689633112;4631.143238500888;4652.13935421948;4673.252279635242 22:52:50 INFO - PROCESS | 18646 | |4;prototype.html;305.9449299126158;312.8607769542553;314.54705224476754;326.73371202469986;330.1054143271733;5290;5332.893342133155;5458.672479651219;5481.561475081994;5506.081776658368;5381.784728610851;5420.972895135528;5433.565314774818;5433.994710978472;5446.509814116729;4245.193413251488;4249.150169966019;4251.447311849455;4276.273033584298;4281.015366465715;4149.004238982638;4217.683673724468;4246.80889359978;4274.700770946035;4286.049847319462;4159.2721273777115;4177.832886684529;4187.413762073312;4189.832406703744;4210.684198685096;4213.0520632857515;4225.42956700846;4231.153769246163;4237.936430953508;4238.321868501025;3729.533808273966;3730.7761534307756;3733.1600389912323;3734.25314937011;3750.643688849555;4973.5275148861165;5253.238280449352;5264.315638966948;5264.473552644743;5271.630985830993;4755.334253204554;4765.428148622153;4770.45139808923;4770.713757174581;4786.617070634341;5333.546648534879;5774.758426938229;5777.59556831022;5780.335261444946;5788.131780232957;3931.8427262909736;3934.704897132698;3944.8027598620242;3947.1908258806875;3949.3681011038097;5914.763409463616;5972.64164150148;5974.970125149433;6015.428534289235;6019.217501724792;3921.450996860442;3978.1446988896946;3983.521977362735;3997.380406037069;4004;4088.5911408858874;4101.097758493127;4102.589741025933;4116.8147433364975;4118.814653340607;4705.247160454311;4722.315264286728;4740.179593142075;4743.098811225925;4750.572448479654;5393.4336894626285;5677.205191273225;5687.289088863892;5706.201131841545;5715.942840571624;1375.0649558300452;1408.985910140906;1421.3299373236405;1423.3737155651481;1424.8361438434506;904.8868891388577;921.0697195832257;940.1256831146962;941.6751220828803;943.4810854030256;4901.09329773993;4913.21388577833;4918.8770280743265;4920.778564964585;4929.802807887716;5816.912746308809;5828.737706803204;5850.5027072699295;5852.180694702745;5855.355910849803;4701.200795864711;4937.284093806378;4939.481354457802;4967.254911763264;5029.4719054498755;3160.683931606821;3193.8722451101694;3196.488561830096;3199.856006479714;3217.6299725531862;5556.333240011144;5564.638298510665;5568.220449137124;5572.637778544382;5602.075657516464;5883.499902508249;6050.21347224858;6116.17431646722;6143.447089761943;6159.168512250879;5540.2243685884005;5544.085225937675;5563.443655634404;5576.0241957657245;5590.91613625796;5600.187972744011;5921.970390148022;5922;5948.10778383246;5980.611260268069;5806;5855.59010869235;5866.149408335853;5868.413158684269;5885;5512.889742205213;5517.917231241454;5563.332400112013;5572.387037425799;5588.469095435927;3827.330217211921;4014.9598504014584;4035.636792688672;4074.4703188585295;4087.8569250076102;5677.687727175045;5731.197632331394;5853.03424934881;5913;5923.229980102559;5691.516221121251;5739.741711623071;5740.885182296247;5763.308402991668;5766.4233576642;5676.772929082956;5715.085586306171;5725.255716756961;5740.1963725077685;5744.827655170351;5509.752061157177;5532.5020748132865;5551.22282880389;5631.88736225265;5654.095344744821;5734.885302294014;5777.24895763548;5780.624259423124;5785.218995435731;5794.797182098607;5516.531094856982;5582.274304340573;5588.748506317307;5598.1322894951345;5626.099824028136 22:52:50 INFO - PROCESS | 18646 | |5;yui.html;620.3672254300614;629.072118625028;634.914286571313;677.1569396101851;707.6072779607316;12237.694057648552;12367.938160309197;12372.628821135359;12406.627801165969;12478.563250286243;11827.822582661245;12319.445624946877;12369.196002259847;12400.81398779019;12420.751584968295;781.577947908129;789.8973133492638;791.651673263765;794.8608993426157;795.5306369242146;789.6604460082162;792.1326147868104;792.6512334572799;792.6948124971899;793.2028311546916;824.8638974569219;825.352098602597;827.4869580859876;828.4863384701493;829.1087081387502;825.6903661127077;825.7068740597092;826.0830478169228;827.230675471811;830.1490971753971;600.198734689186;600.7987324246383;600.855794609295;601.7382438639162;602.1900543768625;11664.6500604982;11684.47419866108;11732.53069877204;11757.88242117585;11767.117466189984;10330.690079297634;10521.684349469528;10544.25667425826;10578.259521833475;10739.677809665722;8312.8337433251;8357;8443.662253509852;8521.10528394522;8561.101084386175;3245.7078862902217;3272.100172452571;3311.718503927169;3323.96676033239;3372.0558243691808;37468.437973430424;39305.41041884374;44048.339274910904;46396.07207855824;46600.533994659956;9834;9927.553260103312;10094.596216151418;10360.740981475523;10450.268481206243;17608.950537548968;17787.555311117067;17870;17934.91032544855;18126.909365453088;7026.578405295699;7107.253738357398;7122.394596459256;7144.3212894774915;7286.562806231643;3686.3548878946076;3789.374753165697;3816.1985982943893;3840.4815349927962;3843.7501562398356;2872.6409198850142;2915.8104723192923;2918.54762511811;2921.576371426131;2951.3064429858964;501.26814850318215;505.29511331692083;510.35185314650926;521.1895502493659;524.5567495466324;553.8864532770772;563.132775525694;565.7878295639135;572.221778381401;576.4466112531933;6783.287754785775;6858.142732158481;6945.7221711132;7083.5041547091205;7333.266673332624;528.5454509122152;529.3674059498939;535.2880668710683;538.4454012367268;544.3413469701626;3412.692857642824;3422.761312938215;3431.3995050866497;3470.1498132957586;3480.077779388464;51547.48452515427;52089.95820083577;53853.461465385626;54674.453255467735;54720.72639636856;41468.585314146476;44593.77703111464;46205.7689711556;46905.061898761836;47048.764756176686;37853.81073094672;38792.80603596964;39491.40762888559;39604.2079158421;40507.7974610131;7702.884456733265;7777.688892444239;7922.841543169219;7941.642626081955;8093.8381232376205;27876.30309242285;28827.7117228825;29021.85489072541;29346.559801602565;29382;35605;36995.815020924725;39576.40635390529;39716.40425393564;40141;9600.423974561549;9644.987276335884;9694.75763105928;9699.515024248618;9832.984238231289;10625.9468702656;10683.94658026705;10697;10706.571737130738;10827.891721083004;9873.259505537257;9920.553575089283;10063.69808905734;10456.424896630759;10484.790304194026;10528.894711052792;10631.362118272928;10909.399983000694;10932.453377331261;11321.320720756452;9825.459599722084;9962.452065136196;10084.14284785772;10092.394456332644;10400.73998150022;8498.787530311793;8788.34087443457;8809.207171354608;9106.95446522763;9218.262538996998;8839.602217900081;8876.467411955304;8906.510141942255;8944.195022448012;9014.774630634287 22:52:50 INFO - PROCESS | 18646 | __end_tp_report 22:52:50 INFO - PROCESS | 18646 | __start_cc_report 22:52:50 INFO - PROCESS | 18646 | _x_x_mozilla_cycle_collect,367 22:52:50 INFO - PROCESS | 18646 | __end_cc_report 22:52:50 INFO - PROCESS | 18646 | __startTimestamp1461304370722__endTimestamp 22:52:50 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | ------- Summary: start ------- 22:52:50 INFO - PROCESS | 18646 | Number of tests: 6 22:52:50 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | [#0] dojo.html Cycles:165 Average:4725.10 Median:4872.07 stddev:595.58 (12.2%) stddev-sans-first:574.20 22:52:50 INFO - PROCESS | 18646 | Values: 2626.5 2704.3 2716.2 2733.7 2736.5 4663.4 4703.7 4706.2 4726.9 4781.5 4642.3 4762.5 4769.8 4820.1 4849.5 4361.7 4442.9 4446.9 4447.4 4447.8 583.8 4323.6 4411.5 4423.4 4476.1 4419.9 4422.8 4435.9 4437.3 4441.8 4393.6 4491.7 4495.0 4499.0 4509.5 4345.3 4382.7 4423.7 4437.7 4462.5 4669.6 4670.5 4716.4 4722.0 4788.8 4991.8 5073.6 5135.4 5206.8 5223.7 5140.1 5168.2 5193.3 5210.1 5223.4 4824.7 4826.3 4829.5 4830.8 4872.6 5182.8 5259.6 5321.2 5335.0 5361.3 5060.0 5060.2 5074.3 5083.9 5114.1 5173.3 5178.6 5194.7 5202.1 5210.7 5024.2 5051.5 5084.5 5092.4 5135.9 4945.1 5108.3 5119.9 5127.5 5151.7 4295.6 4316.9 4318.1 4320.8 4359.0 3695.1 3720.1 3758.7 3767.5 3810.5 4395.4 4397.5 4400.7 4444.7 4460.6 5019.8 5057.5 5079.3 5099.9 5105.4 4428.4 4481.9 4492.0 4525.3 4527.3 4626.3 4635.9 4638.2 4665.6 4712.2 4671.4 4850.6 4889.5 4892.6 4899.9 5142.7 5147.3 5194.0 5199.4 5218.3 4802.7 4831.6 4838.5 4855.7 4896.0 4977.1 5030.2 5067.1 5105.7 5130.6 5169.6 5205.6 5211.2 5221.8 5232.0 5077.4 5080.3 5082.7 5094.6 5098.7 4897.9 4912.1 4938.5 4947.7 4949.2 4824.7 4847.6 4872.1 4895.6 4975.9 5021.3 5038.6 5053.3 5067.3 5116.1 4803.9 4946.4 4969.1 4991.1 5024.9 22:52:50 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | [#1] ext.html Cycles:180 Average:43545.00 Median:191532.56 stddev:77034.68 (40.2%) stddev-sans-first:77183.20 22:52:50 INFO - PROCESS | 18646 | Values: 567.3 586.2 599.4 613.9 630.2 33615.0 34650.8 34817.1 34850.8 34928.5 37545.6 38096.8 38342.6 38410.0 38548.8 7611.8 7749.1 7780.1 7805.5 7806.5 7620.9 7670.5 7716.8 7722.6 7739.8 7643.2 7690.7 7714.4 7721.7 7780.5 7649.2 7657.5 7724.0 7733.2 7744.9 7605.3 7690.9 7694.7 7706.0 7706.3 29658.4 35704.3 36083.1 36108.5 36261.3 2573.5 2699.3 2803.5 2843.8 3358.2 24485.3 25851.0 28408.3 29572.3 29606.6 3359.1 3384.4 3402.9 3413.9 3442.5 170438.0 172399.0 172494.1 173510.0 173898.0 48004.8 48464.0 48520.8 48571.0 48577.5 58567.0 60841.0 60927.0 60965.4 61137.4 13286.5 13432.3 13505.7 13520.8 13526.3 9823.9 9907.6 9940.0 9948.0 9963.4 17766.8 17922.6 18019.9 18432.5 18617.3 6805.2 6950.6 7023.1 7073.4 7111.5 815.5 839.6 952.2 1023.2 1068.3 26268.3 28003.7 28166.3 28353.0 28538.3 958.5 982.9 1007.3 1008.1 1054.8 12938.5 13453.3 13500.5 13676.4 13696.7 346292.0 348248.0 352501.0 353196.0 353303.0 47118.8 48178.0 48242.5 48481.8 48542.0 1226.3 1227.9 1233.0 1254.0 1257.2 25626.7 26214.2 26270.0 26583.0 26995.2 40990.4 41912.8 42161.8 42246.8 42261.6 319311.0 321538.0 321788.0 321894.0 322167.0 25406.4 25647.5 25720.5 25769.0 38201.4 36066.3 36109.6 36420.3 36662.5 40399.8 33941.5 33997.0 34254.3 34474.0 34543.7 33231.7 34225.7 34359.7 34397.5 34601.0 34339.5 34803.3 34849.8 35208.8 35425.5 30452.5 31294.4 31592.5 31632.8 31698.2 23929.5 24081.0 24188.4 24439.4 24766.1 22:52:50 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | [#2] jquery.html Cycles:180 Average:24447.09 Median:27406.69 stddev:67923.50 (247.8%) stddev-sans-first:68090.01 22:52:50 INFO - PROCESS | 18646 | Values: 380.6 383.7 383.9 387.8 392.6 15582.6 16232.7 16800.0 16838.4 16905.2 15552.4 16080.8 16868.5 16881.6 16917.7 5164.0 5290.9 5334.5 5335.7 5341.9 3758.3 5783.8 6158.2 6168.4 6177.7 5037.4 6085.6 6088.1 6098.5 6111.5 5267.7 5280.6 5305.4 5307.7 5310.1 5076.3 5187.5 5304.9 5332.5 5354.8 11614.5 11823.5 12006.6 12011.5 12541.2 1807.4 1981.8 1983.8 2052.8 2269.3 8208.3 8980.3 9253.9 9370.7 11050.9 1716.1 1721.7 1768.9 1781.2 1785.5 61745.0 65628.0 66769.0 67229.7 69583.7 10050.9 10259.5 10358.6 10400.9 10515.9 14271.0 14313.2 14435.2 14497.5 14505.3 6805.6 6809.0 6887.7 6936.6 7023.3 6186.6 6264.3 6327.1 6400.7 6437.5 4400.4 4408.1 4439.7 4459.4 4468.6 1717.7 1740.2 1825.5 1856.4 1883.6 871.3 895.7 899.6 904.7 915.1 15821.0 16273.5 16344.6 16505.7 16604.7 868.3 878.3 893.8 919.9 958.9 9088.0 9244.2 9255.7 9303.6 9474.0 405132.0 410075.0 412284.0 415549.0 417435.0 69328.7 81431.0 81457.0 81572.6 82009.0 908.9 920.8 945.0 946.4 946.6 14326.2 14468.6 14538.1 14577.6 14821.3 34027.7 34848.0 34895.3 35290.8 36162.5 45397.3 48986.8 49554.3 49713.8 49776.0 7212.5 7994.2 8054.0 8083.9 8196.3 9974.0 11501.4 11580.4 11664.5 11778.6 8304.5 9844.1 9848.5 9932.3 10075.2 9977.9 10170.4 10230.2 10371.2 10693.0 5778.8 8335.9 9976.8 10290.7 10501.2 7860.5 7876.3 7923.7 7997.9 8043.4 9716.0 9979.0 10178.1 10223.7 10239.3 22:52:50 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | [#3] mootools.html Cycles:180 Average:5189.33 Median:5022.02 stddev:2894.06 (57.6%) stddev-sans-first:2887.93 22:52:50 INFO - PROCESS | 18646 | Values: 1367.2 1431.7 1553.9 1724.1 1732.5 6990.9 7323.6 7565.0 7601.0 7645.8 7810.3 7864.4 7933.0 7936.4 7946.5 2296.4 2330.5 2331.7 2331.8 2333.9 2236.6 2287.6 2297.3 2304.5 2306.8 2281.6 2294.0 2302.0 2322.1 2335.0 2228.0 2229.6 2231.2 2239.9 2252.3 2222.5 2230.1 2238.7 2248.0 2248.8 7872.4 7913.6 7918.8 7919.8 7927.9 4547.8 4658.2 4668.5 4671.6 4676.0 2889.7 2964.9 2972.2 2989.5 3030.5 986.8 986.9 992.8 997.9 1013.6 10720.5 10833.6 10843.3 10856.3 10864.0 4311.1 4331.5 4470.5 4494.4 4496.4 9066.9 9097.2 9104.8 9121.4 9122.4 4865.1 4870.4 4876.4 4882.5 4891.6 3725.2 4144.1 4282.3 4287.2 4432.2 3616.7 3694.3 3755.2 3773.9 3805.8 1194.1 1257.9 1273.5 1282.6 1285.0 752.9 783.8 794.4 807.5 823.9 5152.4 5351.0 5359.1 5390.5 5399.6 432.6 433.8 437.2 440.3 450.7 3416.9 3469.1 3469.6 3513.1 3518.3 9334.9 9811.6 9868.1 9871.9 9900.5 9609.6 9691.1 9737.1 9770.4 9810.2 7392.3 7455.9 7473.8 7473.9 7492.4 5155.9 5156.8 5164.8 5406.2 5414.9 8721.6 8784.5 8829.7 8855.5 8946.5 8781.6 8888.3 8958.3 9011.7 9127.9 6614.1 7094.8 7228.0 7346.7 7363.7 7548.7 7624.2 7632.4 7658.0 7674.8 6658.1 6810.9 6812.2 6944.8 6957.8 6557.1 6617.6 6631.3 6645.6 6717.7 6115.1 6115.5 6206.5 6244.2 6260.0 4535.7 4584.8 4591.2 4605.4 4652.7 4497.1 4563.3 4631.1 4652.1 4673.3 22:52:50 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | [#4] prototype.html Cycles:180 Average:4715.41 Median:5427.27 stddev:1393.12 (25.7%) stddev-sans-first:1357.14 22:52:50 INFO - PROCESS | 18646 | Values: 305.9 312.9 314.5 326.7 330.1 5290.0 5332.9 5458.7 5481.6 5506.1 5381.8 5421.0 5433.6 5434.0 5446.5 4245.2 4249.2 4251.4 4276.3 4281.0 4149.0 4217.7 4246.8 4274.7 4286.0 4159.3 4177.8 4187.4 4189.8 4210.7 4213.1 4225.4 4231.2 4237.9 4238.3 3729.5 3730.8 3733.2 3734.3 3750.6 4973.5 5253.2 5264.3 5264.5 5271.6 4755.3 4765.4 4770.5 4770.7 4786.6 5333.5 5774.8 5777.6 5780.3 5788.1 3931.8 3934.7 3944.8 3947.2 3949.4 5914.8 5972.6 5975.0 6015.4 6019.2 3921.5 3978.1 3983.5 3997.4 4004.0 4088.6 4101.1 4102.6 4116.8 4118.8 4705.2 4722.3 4740.2 4743.1 4750.6 5393.4 5677.2 5687.3 5706.2 5715.9 1375.1 1409.0 1421.3 1423.4 1424.8 904.9 921.1 940.1 941.7 943.5 4901.1 4913.2 4918.9 4920.8 4929.8 5816.9 5828.7 5850.5 5852.2 5855.4 4701.2 4937.3 4939.5 4967.3 5029.5 3160.7 3193.9 3196.5 3199.9 3217.6 5556.3 5564.6 5568.2 5572.6 5602.1 5883.5 6050.2 6116.2 6143.4 6159.2 5540.2 5544.1 5563.4 5576.0 5590.9 5600.2 5922.0 5922.0 5948.1 5980.6 5806.0 5855.6 5866.1 5868.4 5885.0 5512.9 5517.9 5563.3 5572.4 5588.5 3827.3 4015.0 4035.6 4074.5 4087.9 5677.7 5731.2 5853.0 5913.0 5923.2 5691.5 5739.7 5740.9 5763.3 5766.4 5676.8 5715.1 5725.3 5740.2 5744.8 5509.8 5532.5 5551.2 5631.9 5654.1 5734.9 5777.2 5780.6 5785.2 5794.8 5516.5 5582.3 5588.7 5598.1 5626.1 22:52:50 INFO - PROCESS | 18646 | 22:52:50 INFO - PROCESS | 18646 | [#5] yui.html Cycles:180 Average:12282.46 Median:507.82 stddev:14098.87 (2776.3%) stddev-sans-first:14111.22 22:52:50 INFO - PROCESS | 18646 | Values: 620.4 629.1 634.9 677.2 707.6 12237.7 12367.9 12372.6 12406.6 12478.6 11827.8 12319.4 12369.2 12400.8 12420.8 781.6 789.9 791.7 794.9 795.5 789.7 792.1 792.7 792.7 793.2 824.9 825.4 827.5 828.5 829.1 825.7 825.7 826.1 827.2 830.1 600.2 600.8 600.9 601.7 602.2 11664.7 11684.5 11732.5 11757.9 11767.1 10330.7 10521.7 10544.3 10578.3 10739.7 8312.8 8357.0 8443.7 8521.1 8561.1 3245.7 3272.1 3311.7 3324.0 3372.1 37468.4 39305.4 44048.3 46396.1 46600.5 9834.0 9927.6 10094.6 10360.7 10450.3 17609.0 17787.6 17870.0 17934.9 18126.9 7026.6 7107.3 7122.4 7144.3 7286.6 3686.4 3789.4 3816.2 3840.5 3843.8 2872.6 2915.8 2918.5 2921.6 2951.3 501.3 505.3 510.4 521.2 524.6 553.9 563.1 565.8 572.2 576.4 6783.3 6858.1 6945.7 7083.5 7333.3 528.5 529.4 535.3 538.4 544.3 3412.7 3422.8 3431.4 3470.1 3480.1 51547.5 52090.0 53853.5 54674.5 54720.7 41468.6 44593.8 46205.8 46905.1 47048.8 37853.8 38792.8 39491.4 39604.2 40507.8 7702.9 7777.7 7922.8 7941.6 8093.8 27876.3 28827.7 29021.9 29346.6 29382.0 35605.0 36995.8 39576.4 39716.4 40141.0 9600.4 9645.0 9694.8 9699.5 9833.0 10625.9 10683.9 10697.0 10706.6 10827.9 9873.3 9920.6 10063.7 10456.4 10484.8 10528.9 10631.4 10909.4 10932.5 11321.3 9825.5 9962.5 10084.1 10092.4 10400.7 8498.8 8788.3 8809.2 9107.0 9218.3 8839.6 8876.5 8906.5 8944.2 9014.8 22:52:50 INFO - PROCESS | 18646 | -------- Summary: end -------- 22:52:50 INFO - PROCESS | 18646 | 22:52:51 INFO - TEST-INFO | 18646: exit 0 22:52:51 INFO - TEST-OK | dromaeo_css | took 1114621ms 22:52:51 INFO - TEST-START | kraken 22:52:51 INFO - operating with platform_type : linux_ 22:52:51 INFO - Initialising browser for kraken test... 22:52:51 INFO - TEST-INFO | started process 18877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprZhLNP/profile http://localhost:32814/getInfo.html) 22:52:55 INFO - PROCESS | 18877 | 22:52:55 INFO - PROCESS | 18877 | (process:18945): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:52:55 INFO - PROCESS | 18877 | __metrics Screen width/height:1600/1200 22:52:55 INFO - PROCESS | 18877 | colorDepth:24 22:52:55 INFO - PROCESS | 18877 | Browser inner width/height: 1024/697 22:52:55 INFO - PROCESS | 18877 | __metrics 22:52:56 ERROR - PROCESS | 18877 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:52:57 INFO - TEST-INFO | 18877: exit 0 22:52:57 INFO - Browser initialized. 22:52:57 INFO - Running cycle 1/1 for kraken test... 22:52:57 INFO - TEST-INFO | started process 18996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprZhLNP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:59 INFO - PROCESS | 18996 | 22:52:59 INFO - PROCESS | 18996 | (process:19058): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:53:09 INFO - PROCESS | 18996 | RSS: Main: 165371904 22:53:09 INFO - PROCESS | 18996 | 22:53:11 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32814/tests/kraken/driver.html?testName=audio-beat-detection) 22:53:12 INFO - PROCESS | 18996 | RSS: Main: 170110976 22:53:12 INFO - PROCESS | 18996 | 22:53:15 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32814/tests/kraken/driver.html?testName=audio-dft) 22:53:16 INFO - PROCESS | 18996 | RSS: Main: 173252608 22:53:16 INFO - PROCESS | 18996 | 22:53:19 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32814/tests/kraken/driver.html?testName=audio-fft) 22:53:19 INFO - PROCESS | 18996 | RSS: Main: 164847616 22:53:19 INFO - PROCESS | 18996 | 22:53:21 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32814/tests/kraken/driver.html?testName=audio-oscillator) 22:53:22 INFO - PROCESS | 18996 | RSS: Main: 165310464 22:53:22 INFO - PROCESS | 18996 | 22:53:24 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:53:25 INFO - PROCESS | 18996 | RSS: Main: 166023168 22:53:25 INFO - PROCESS | 18996 | 22:53:28 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32814/tests/kraken/driver.html?testName=imaging-darkroom) 22:53:29 INFO - PROCESS | 18996 | RSS: Main: 165642240 22:53:29 INFO - PROCESS | 18996 | 22:53:32 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32814/tests/kraken/driver.html?testName=imaging-desaturate) 22:53:33 INFO - PROCESS | 18996 | RSS: Main: 165507072 22:53:33 INFO - PROCESS | 18996 | 22:53:36 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32814/tests/kraken/driver.html?testName=json-parse-financial) 22:53:36 INFO - PROCESS | 18996 | RSS: Main: 165388288 22:53:36 INFO - PROCESS | 18996 | 22:53:38 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:53:39 INFO - PROCESS | 18996 | RSS: Main: 166113280 22:53:39 INFO - PROCESS | 18996 | 22:53:41 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:53:41 INFO - PROCESS | 18996 | RSS: Main: 166465536 22:53:41 INFO - PROCESS | 18996 | 22:53:43 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:53:44 INFO - PROCESS | 18996 | RSS: Main: 166776832 22:53:44 INFO - PROCESS | 18996 | 22:53:47 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:53:48 INFO - PROCESS | 18996 | RSS: Main: 167624704 22:53:48 INFO - PROCESS | 18996 | 22:53:51 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:53:51 INFO - PROCESS | 18996 | RSS: Main: 166899712 22:53:51 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | Cycle 1(1): loaded http://localhost:32814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32814/tests/kraken/driver.html?testName=ai-astar) 22:53:53 INFO - PROCESS | 18996 | RSS: Main: 168333312 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | __start_tp_report 22:53:53 INFO - PROCESS | 18996 | _x_x_mozilla_page_load 22:53:53 INFO - PROCESS | 18996 | _x_x_mozilla_page_load_details 22:53:53 INFO - PROCESS | 18996 | |i|pagename|runs| 22:53:53 INFO - PROCESS | 18996 | |0;ai-astar;113;110;113;114;114;126;113;112;113;114 22:53:53 INFO - PROCESS | 18996 | |1;audio-beat-detection;162;134;157;198;136;162;167;134;190;134 22:53:53 INFO - PROCESS | 18996 | |2;audio-dft;162;163;163;168;173;163;163;166;166;164 22:53:53 INFO - PROCESS | 18996 | |3;audio-fft;80;75;74;175;76;75;73;74;162;78 22:53:53 INFO - PROCESS | 18996 | |4;audio-oscillator;93;94;163;94;96;94;144;93;94;140 22:53:53 INFO - PROCESS | 18996 | |5;imaging-gaussian-blur;118;118;118;117;117;118;119;117;118;118 22:53:53 INFO - PROCESS | 18996 | |6;imaging-darkroom;147;153;148;148;149;150;150;147;148;148 22:53:53 INFO - PROCESS | 18996 | |7;imaging-desaturate;96;96;95;96;97;96;97;95;97;94 22:53:53 INFO - PROCESS | 18996 | |8;json-parse-financial;67;66;67;65;70;69;65;66;66;66 22:53:53 INFO - PROCESS | 18996 | |9;json-stringify-tinderbox;64;65;64;65;66;65;65;64;65;64 22:53:53 INFO - PROCESS | 18996 | |10;stanford-crypto-aes;80;81;80;83;80;81;81;81;110;80 22:53:53 INFO - PROCESS | 18996 | |11;stanford-crypto-ccm;137;144;136;155;137;135;140;145;139;141 22:53:53 INFO - PROCESS | 18996 | |12;stanford-crypto-pbkdf2;183;179;182;181;186;189;181;188;181;176 22:53:53 INFO - PROCESS | 18996 | |13;stanford-crypto-sha256-iterative;73;72;75;75;76;80;76;74;75;77 22:53:53 INFO - PROCESS | 18996 | __end_tp_report 22:53:53 INFO - PROCESS | 18996 | __start_cc_report 22:53:53 INFO - PROCESS | 18996 | _x_x_mozilla_cycle_collect,906 22:53:53 INFO - PROCESS | 18996 | __end_cc_report 22:53:53 INFO - PROCESS | 18996 | __startTimestamp1461304433829__endTimestamp 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | ------- Summary: start ------- 22:53:53 INFO - PROCESS | 18996 | Number of tests: 14 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#0] ai-astar Cycles:10 Average:114.20 Median:113.50 stddev:4.32 (3.8%) stddev-sans-first:4.56 22:53:53 INFO - PROCESS | 18996 | Values: 113.0 110.0 113.0 114.0 114.0 126.0 113.0 112.0 113.0 114.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:162.00 stddev:23.44 (14.5%) stddev-sans-first:24.81 22:53:53 INFO - PROCESS | 18996 | Values: 162.0 134.0 157.0 198.0 136.0 162.0 167.0 134.0 190.0 134.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.35 (2.0%) stddev-sans-first:3.36 22:53:53 INFO - PROCESS | 18996 | Values: 162.0 163.0 163.0 168.0 173.0 163.0 163.0 166.0 166.0 164.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:39.33 (52.4%) stddev-sans-first:41.38 22:53:53 INFO - PROCESS | 18996 | Values: 80.0 75.0 74.0 175.0 76.0 75.0 73.0 74.0 162.0 78.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:94.00 stddev:27.20 (28.9%) stddev-sans-first:28.11 22:53:53 INFO - PROCESS | 18996 | Values: 93.0 94.0 163.0 94.0 96.0 94.0 144.0 93.0 94.0 140.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 22:53:53 INFO - PROCESS | 18996 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 119.0 117.0 118.0 118.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.50 stddev:1.81 (1.2%) stddev-sans-first:1.80 22:53:53 INFO - PROCESS | 18996 | Values: 147.0 153.0 148.0 148.0 149.0 150.0 150.0 147.0 148.0 148.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 22:53:53 INFO - PROCESS | 18996 | Values: 96.0 96.0 95.0 96.0 97.0 96.0 97.0 95.0 97.0 94.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:66.50 stddev:1.64 (2.5%) stddev-sans-first:1.73 22:53:53 INFO - PROCESS | 18996 | Values: 67.0 66.0 67.0 65.0 70.0 69.0 65.0 66.0 66.0 66.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 22:53:53 INFO - PROCESS | 18996 | Values: 64.0 65.0 64.0 65.0 66.0 65.0 65.0 64.0 65.0 64.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:81.00 stddev:9.29 (11.5%) stddev-sans-first:9.75 22:53:53 INFO - PROCESS | 18996 | Values: 80.0 81.0 80.0 83.0 80.0 81.0 81.0 81.0 110.0 80.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:140.50 stddev:5.95 (4.2%) stddev-sans-first:6.14 22:53:53 INFO - PROCESS | 18996 | Values: 137.0 144.0 136.0 155.0 137.0 135.0 140.0 145.0 139.0 141.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.60 Median:182.50 stddev:4.03 (2.2%) stddev-sans-first:4.28 22:53:53 INFO - PROCESS | 18996 | Values: 183.0 179.0 182.0 181.0 186.0 189.0 181.0 188.0 181.0 176.0 22:53:53 INFO - PROCESS | 18996 | 22:53:53 INFO - PROCESS | 18996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.50 stddev:2.21 (2.9%) stddev-sans-first:2.19 22:53:53 INFO - PROCESS | 18996 | Values: 73.0 72.0 75.0 75.0 76.0 80.0 76.0 74.0 75.0 77.0 22:53:53 INFO - PROCESS | 18996 | -------- Summary: end -------- 22:53:53 INFO - PROCESS | 18996 | 22:53:54 INFO - TEST-INFO | 18996: exit 0 22:53:54 INFO - TEST-OK | kraken | took 63357ms 22:53:54 INFO - SUITE-END | took 1177s 22:53:54 INFO - Completed test suite (00:19:38) 22:53:54 INFO - javascript benchmark 22:53:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.4878348722, 2704.2968828104695, 2716.1851444566623, 2733.685626152993, 2736.507428662841, 4663.440387153542, 4703.670743047984, 4706.247000479924, 4726.881827954303, 4781.545753153454, 4642.257238841786, 4762.547557981986, 4769.761511924398, 4820.0600882827775, 4849.515048495149, 4361.672874534399, 4442.933355999663, 4446.933296000562, 4447.4218351614245, 4447.755373454459, 583.7650988765697, 4323.567643235667, 4411.536788637195, 4423.402840616508, 4476.060027394251, 4419.911601767979, 4422.84520041797, 4435.889102772457, 4437.334399840018, 4441.75570343631, 4393.626541743955, 4491.6855820092605, 4495.033567782943, 4498.955010449919, 4509.4814096379005, 4345.304751239818, 4382.693211475198, 4423.712458690175, 4437.667174961858, 4462.509123996358, 4669.626429885635, 4670.5329467053025, 4716.38686970695, 4721.976390118062, 4788.80844766209, 4991.825286114969, 5073.568746656539, 5135.3837539495125, 5206.817761378334, 5223.71269580173, 5140.074786538422, 5168.198929165986, 5193.324867767204, 5210.114280572274, 5223.425423203445, 4824.734639594786, 4826.32431459596, 4829.492903245108, 4830.758462076882, 4872.634552408584, 5182.766775495112, 5259.631825772236, 5321.228421878806, 5335.039692855245, 5361.303030606075, 5059.974700126476, 5060.1903695408555, 5074.340335756328, 5083.898322033612, 5114.130597798308, 5173.275741396207, 5178.637495375363, 5194.740262986911, 5202.1416466282635, 5210.739463026834, 5024.196128619404, 5051.4695956924725, 5084.542391184811, 5092.388913330424, 5135.897282054338, 4945.085159245551, 5108.259302401131, 5119.948800512022, 5127.46161653021, 5151.665141765773, 4295.634871035934, 4316.913661726748, 4318.114786468766, 4320.827166913351, 4359.041010977643, 3695.0762309422644, 3720.088578298334, 3758.7180961428003, 3767.5102236709054, 3810.466534685146, 4395.406620106309, 4397.450318710161, 4400.69195156336, 4444.666650001198, 4460.576245256695, 5019.799208031711, 5057.468965758542, 5079.339685840817, 5099.898002039939, 5105.412877519058, 4428.357888106207, 4481.887952801206, 4492.0, 4525.321201819754, 4527.253003254492, 4626.259798432235, 4635.907281854344, 4638.165130276582, 4665.5567721066445, 4712.175369310357, 4671.3927189464475, 4850.587700045536, 4889.48660390661, 4892.559669629751, 4899.853004409873, 5142.742862856917, 5147.279380886604, 5194.0, 5199.4020687621405, 5218.26944227816, 4802.6638135330195, 4831.589314908272, 4838.540338667821, 4855.6601037927, 4895.951040489549, 4977.054359671651, 5030.245463180552, 5067.113255180255, 5105.668131571436, 5130.58955283569, 5169.612279079009, 5205.557527610044, 5211.218317252443, 5221.817236396708, 5232.03207406631, 5077.416097148875, 5080.339555857715, 5082.669626474268, 5094.617903657315, 5098.668586541863, 4897.853064408074, 4912.066707325596, 4938.506149385033, 4947.727874966768, 4949.232868905326, 4824.662273640952, 4847.587955023721, 4872.074305881871, 4895.632827537877, 4975.875603109951, 5021.347224860745, 5038.647294689336, 5053.31780209667, 5067.2652465391575, 5116.053530096795, 4803.855884323476, 4946.431160416598, 4969.130402179677, 4991.126552853309, 5024.924626130538], "value": 4689.203366471021, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3333832746524, 586.1617886422417, 599.4095815621613, 613.9355367686394, 630.1902055858218, 33615.0, 34650.826745866296, 34817.129571760684, 34850.82574587123, 34928.476072858924, 37545.62454375455, 38096.80951595238, 38342.61657383425, 38410.0, 38548.80725596375, 7611.809704757384, 7749.070111586618, 7780.14418413974, 7805.492642978216, 7806.5316081035035, 7620.885686714703, 7670.463067585271, 7716.768496945073, 7722.61386930654, 7739.845203095934, 7643.197464266255, 7690.692372305129, 7714.421418393643, 7721.652525636332, 7780.494267872598, 7649.1585925548425, 7657.4639775215755, 7723.995880535523, 7733.226677332278, 7744.922550774533, 7605.277498637621, 7690.884636730453, 7694.730684426074, 7705.961470192669, 7706.344960678349, 29658.40683186324, 35704.28591428183, 36083.09792255188, 36108.45837312443, 36261.27477450436, 2573.5238980788426, 2699.284689557269, 2803.5487206891676, 2843.8009339346254, 3358.227607650254, 24485.26544203677, 25851.0, 28408.28979275514, 29572.26069348262, 29606.555901661493, 3359.0930448778936, 3384.424647809878, 3402.8638854445794, 3413.9317213655586, 3442.535257740198, 170438.0, 172399.0, 172494.1375293128, 173510.0, 173898.0, 48004.75997620059, 48464.0, 48520.7573962135, 48571.0, 48577.51422485801, 58567.0, 60841.0, 60927.0, 60965.39034609686, 61137.38862611317, 13286.53497127596, 13432.328383580782, 13505.729885402434, 13520.79718804199, 13526.25605591702, 9823.901760982299, 9907.554160062815, 9939.950300248453, 9948.0, 9963.352382095141, 17766.822331776515, 17922.641547168983, 18019.918804871748, 18432.539186520175, 18617.348392806456, 6805.183377994574, 6950.6177160256675, 7023.122109736283, 7073.398761105261, 7111.502194846415, 815.5269943432795, 839.5760141128691, 952.2334520710756, 1023.1712313026472, 1068.257560995101, 26268.343291417867, 28003.71996280052, 28166.29584260369, 28353.0, 28538.286542836595, 958.5399008475971, 982.9361091529028, 1007.2747621712356, 1008.1027885182194, 1054.7784965157402, 12938.482460701654, 13453.327333633279, 13500.459981600823, 13676.42721087068, 13696.726065478833, 346292.0, 348248.0, 352501.0, 353196.0, 353303.0, 47118.76440617775, 48178.0, 48242.5175748238, 48481.757591212525, 48542.0, 1226.3439060102803, 1227.8526576810661, 1232.969175770595, 1254.0469243374919, 1257.1891130220956, 25626.743732562434, 26214.213573592824, 26270.0, 26583.0, 26995.190144295702, 40990.38514422346, 41912.80871912785, 42161.789191053846, 42246.78876605597, 42261.57738422576, 319311.0, 321538.0, 321788.0, 321894.0, 322167.0, 25406.364840879127, 25647.487050259264, 25720.485590287713, 25769.0, 38201.42697859479, 36066.27867442584, 36109.63890361063, 36420.27159456743, 36662.450063248536, 40399.7980010098, 33941.49087763735, 33997.0, 34254.31491370109, 34474.0, 34543.654563454045, 33231.667683322856, 34225.65774342225, 34359.65640343565, 34397.484037738956, 34601.0, 34339.484907725906, 34803.303933921685, 34849.82575087108, 35208.823955880056, 35425.468617971266, 30452.543211851396, 31294.37411251808, 31592.526112108797, 31632.841835790674, 31698.207544811565, 23929.52140957206, 24081.0, 24188.39529011789, 24439.38901527476, 24766.133185338425], "value": 16859.64783442159, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.568055257283, 383.6738772043763, 383.9001859516525, 387.7964068863847, 392.59366555614946, 15582.630863527493, 16232.675346493077, 16800.0, 16838.41065562704, 16905.154742262897, 15552.377904883819, 16080.75878861815, 16868.493945181664, 16881.577960550992, 16917.7462338065, 5164.0, 5290.894182116355, 5334.466553344654, 5335.653182543142, 5341.866453338659, 3758.267137908109, 5783.826485205451, 6158.168647232634, 6168.383161683818, 6177.691115444232, 5037.370328708911, 6085.574009819315, 6088.117223002662, 6098.512119030467, 6111.541634377417, 5267.683938963655, 5280.630355875091, 5305.44292849253, 5307.73461326934, 5310.07073762092, 5076.314697515825, 5187.507186817246, 5304.893902121975, 5332.546733527654, 5354.839354819362, 11614.535418583246, 11823.467943942544, 12006.63980080599, 12011.519539218421, 12541.184822986568, 1807.3945228348387, 1981.7919118492496, 1983.7520309961255, 2052.8049835265624, 2269.262489690857, 8208.343332533383, 8980.326475514363, 9253.861192082124, 9370.718878433658, 11050.944745276222, 1716.1419290354822, 1721.6571074561737, 1768.8761786674938, 1781.2429717370067, 1785.4643606917873, 61745.0, 65628.0, 66769.0, 67229.66385168042, 69583.65208173927, 10050.949745251228, 10259.487025648688, 10358.637447689294, 10400.947995260127, 10515.894841051644, 14271.0, 14313.21277329736, 14435.206063666388, 14497.492587759378, 14505.274736263356, 6805.557638753465, 6808.965955170292, 6887.690053947585, 6936.583804971718, 7023.262557431396, 6186.628802271878, 6264.310925798159, 6327.082573026885, 6400.7119679614525, 6437.517186210959, 4400.405945197357, 4408.118376324684, 4439.7336159829865, 4459.397981272552, 4468.642508599304, 1717.7337512685554, 1740.1821144062271, 1825.5344887053982, 1856.4337876947661, 1883.5667796406904, 871.2986046232717, 895.6954635423987, 899.5637115998735, 904.6788390121412, 915.0940568836803, 15821.0, 16273.51179464618, 16344.591385215226, 16505.6698866022, 16604.6679066418, 868.2880038368477, 878.3149143667949, 893.821235752852, 919.8574220995756, 958.8609651600478, 9087.954560227157, 9244.214241789523, 9255.67605133817, 9303.58133883977, 9473.952630236943, 405132.0, 410075.0, 412284.0, 415549.0, 417435.0, 69328.65335673289, 81431.0, 81457.0, 81572.59213704012, 82009.0, 908.909109089099, 920.7836158502613, 945.0455040409237, 946.4368700623256, 946.6024269806697, 14326.212058336892, 14468.565943021726, 14538.127712337293, 14577.562673119823, 14821.25893705332, 34027.65972340245, 34848.0, 34895.30209395849, 35290.82354588313, 36162.4575631371, 45397.31904021509, 48986.75506622444, 49554.25668614901, 49713.751431242614, 49776.0, 7212.459065570209, 7994.1606131355375, 8053.959730201312, 8083.9191608083165, 8196.303314218358, 9974.0, 11501.424928753697, 11580.36308003068, 11664.533418663159, 11778.646640600795, 8304.460210086567, 9844.114029737359, 9848.458334791656, 9932.304738668225, 10075.244356673133, 9977.900220997697, 10170.389776613427, 10230.181585473294, 10371.222158338003, 10693.0, 5778.8266352009505, 8335.874961875455, 9976.800463990825, 10290.691279261635, 10501.212409069503, 7860.489068210548, 7876.330511906552, 7923.7226697065325, 7997.880031799411, 8043.356531477585, 9716.0, 9978.950105249718, 10178.083972442515, 10223.693289201336, 10239.334443261165], "value": 8052.281056306077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.2480135925239, 1431.6778724786925, 1553.914534700591, 1724.0862342958237, 1732.4889157698478, 6990.930090699091, 7323.560586364822, 7565.0, 7601.049868766404, 7645.770626881189, 7810.258025487584, 7864.410169237316, 7933.0, 7936.44444888858, 7946.4834785738885, 2296.391456264091, 2330.463993281546, 2331.6968794056834, 2331.80179684727, 2333.9299821005397, 2236.552689462114, 2287.622542280522, 2297.322289924468, 2304.493011537459, 2306.8039216666602, 2281.589313923493, 2294.0, 2302.033146078651, 2322.082777302964, 2335.019291897407, 2227.9888600556974, 2229.598672238996, 2231.2190733243397, 2239.9104035838545, 2252.3468194223656, 2222.533268013719, 2230.130249202812, 2238.675392068141, 2247.955040899189, 2248.7976082152522, 7872.448928575002, 7913.604319784045, 7918.80202994924, 7919.841603167904, 7927.920720792834, 4547.795349209294, 4658.18481765693, 4668.463126740435, 4671.556202160789, 4676.0, 2889.6965818588956, 2964.9110526684235, 2972.2420782700488, 2989.491786396296, 3030.4545181867256, 986.8223719730446, 986.8667729856521, 992.7964767222775, 997.9051990060933, 1013.6350913671073, 10720.51757670899, 10833.620823271227, 10843.349399036084, 10856.3486190828, 10864.0, 4311.051568654891, 4331.523532411432, 4470.530594287618, 4494.438195225597, 4496.3705081288645, 9066.909330906607, 9097.1812536872, 9104.817903642022, 9121.36150469474, 9122.407043542149, 4865.0756356292195, 4870.4155501340065, 4876.366072410564, 4882.511748825089, 4891.63312751538, 3725.2177042820767, 4144.129732756095, 4282.293421585466, 4287.206866729665, 4432.15789000089, 3616.692581130581, 3694.261147770403, 3755.1550901047594, 3773.867914622975, 3805.82873770681, 1194.1223200947297, 1257.9182353147016, 1273.4587800184884, 1282.602393258093, 1285.0041218055894, 752.8531936272484, 783.8314762326128, 794.3724457678485, 807.5316316536395, 823.8640624297044, 5152.407473140562, 5351.0, 5359.088954877602, 5390.51485366311, 5399.622026458189, 432.61929502038635, 433.8329743048949, 437.24138619495153, 440.3109134204959, 450.69803231834095, 3416.8804091857164, 3469.080693616194, 3469.583649962021, 3513.1217195701074, 3518.313928783914, 9334.859977100348, 9811.558479868423, 9868.062534059252, 9871.901280987242, 9900.455474948947, 9609.615615375447, 9691.12779849817, 9737.123658870736, 9770.413775173512, 9810.215182785503, 7392.334689877829, 7455.925440745632, 7473.813154671177, 7473.887891681629, 7492.438067144986, 5155.896882062413, 5156.845294641167, 5164.845054648366, 5406.21609866575, 5414.945850541601, 8721.563921803758, 8784.516851573226, 8829.69096081634, 8855.468671879707, 8946.463212207289, 8781.648734050821, 8888.333374996771, 8958.3427065993, 9011.729648110568, 9127.863082053642, 6614.140161778938, 7094.751683691253, 7228.0, 7346.706131754884, 7363.705451781869, 7548.698052078075, 7624.237576242332, 7632.3512501438, 7657.961710191414, 7674.846503070019, 6658.1011563438315, 6810.863782724218, 6812.182538095461, 6944.826379340557, 6957.826054348682, 6557.147570815763, 6617.636030018202, 6631.33686631333, 6645.634490102897, 6717.731290748511, 6115.1438798569125, 6115.480184184216, 6206.503479721521, 6244.1570387997035, 6259.96870015647, 4535.727856328631, 4584.793684284282, 4591.242444996538, 4605.37827393311, 4652.697574657636, 4497.123061003073, 4563.292689633112, 4631.143238500888, 4652.13935421948, 4673.252279635242], "value": 4135.119109167331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.9449299126158, 312.8607769542553, 314.54705224476754, 326.73371202469986, 330.1054143271733, 5290.0, 5332.893342133155, 5458.672479651219, 5481.561475081994, 5506.081776658368, 5381.784728610851, 5420.972895135528, 5433.565314774818, 5433.994710978472, 5446.509814116729, 4245.193413251488, 4249.150169966019, 4251.447311849455, 4276.273033584298, 4281.015366465715, 4149.004238982638, 4217.683673724468, 4246.80889359978, 4274.700770946035, 4286.049847319462, 4159.2721273777115, 4177.832886684529, 4187.413762073312, 4189.832406703744, 4210.684198685096, 4213.0520632857515, 4225.42956700846, 4231.153769246163, 4237.936430953508, 4238.321868501025, 3729.533808273966, 3730.7761534307756, 3733.1600389912323, 3734.25314937011, 3750.643688849555, 4973.5275148861165, 5253.238280449352, 5264.315638966948, 5264.473552644743, 5271.630985830993, 4755.334253204554, 4765.428148622153, 4770.45139808923, 4770.713757174581, 4786.617070634341, 5333.546648534879, 5774.758426938229, 5777.59556831022, 5780.335261444946, 5788.131780232957, 3931.8427262909736, 3934.704897132698, 3944.8027598620242, 3947.1908258806875, 3949.3681011038097, 5914.763409463616, 5972.64164150148, 5974.970125149433, 6015.428534289235, 6019.217501724792, 3921.450996860442, 3978.1446988896946, 3983.521977362735, 3997.380406037069, 4004.0, 4088.5911408858874, 4101.097758493127, 4102.589741025933, 4116.8147433364975, 4118.814653340607, 4705.247160454311, 4722.315264286728, 4740.179593142075, 4743.098811225925, 4750.572448479654, 5393.4336894626285, 5677.205191273225, 5687.289088863892, 5706.201131841545, 5715.942840571624, 1375.0649558300452, 1408.985910140906, 1421.3299373236405, 1423.3737155651481, 1424.8361438434506, 904.8868891388577, 921.0697195832257, 940.1256831146962, 941.6751220828803, 943.4810854030256, 4901.09329773993, 4913.21388577833, 4918.8770280743265, 4920.778564964585, 4929.802807887716, 5816.912746308809, 5828.737706803204, 5850.5027072699295, 5852.180694702745, 5855.355910849803, 4701.200795864711, 4937.284093806378, 4939.481354457802, 4967.254911763264, 5029.4719054498755, 3160.683931606821, 3193.8722451101694, 3196.488561830096, 3199.856006479714, 3217.6299725531862, 5556.333240011144, 5564.638298510665, 5568.220449137124, 5572.637778544382, 5602.075657516464, 5883.499902508249, 6050.21347224858, 6116.17431646722, 6143.447089761943, 6159.168512250879, 5540.2243685884005, 5544.085225937675, 5563.443655634404, 5576.0241957657245, 5590.91613625796, 5600.187972744011, 5921.970390148022, 5922.0, 5948.10778383246, 5980.611260268069, 5806.0, 5855.59010869235, 5866.149408335853, 5868.413158684269, 5885.0, 5512.889742205213, 5517.917231241454, 5563.332400112013, 5572.387037425799, 5588.469095435927, 3827.330217211921, 4014.9598504014584, 4035.636792688672, 4074.4703188585295, 4087.8569250076102, 5677.687727175045, 5731.197632331394, 5853.03424934881, 5913.0, 5923.229980102559, 5691.516221121251, 5739.741711623071, 5740.885182296247, 5763.308402991668, 5766.4233576642, 5676.772929082956, 5715.085586306171, 5725.255716756961, 5740.1963725077685, 5744.827655170351, 5509.752061157177, 5532.5020748132865, 5551.22282880389, 5631.88736225265, 5654.095344744821, 5734.885302294014, 5777.24895763548, 5780.624259423124, 5785.218995435731, 5794.797182098607, 5516.531094856982, 5582.274304340573, 5588.748506317307, 5598.1322894951345, 5626.099824028136], "value": 4264.731125740219, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.3672254300614, 629.072118625028, 634.914286571313, 677.1569396101851, 707.6072779607316, 12237.694057648552, 12367.938160309197, 12372.628821135359, 12406.627801165969, 12478.563250286243, 11827.822582661245, 12319.445624946877, 12369.196002259847, 12400.81398779019, 12420.751584968295, 781.577947908129, 789.8973133492638, 791.651673263765, 794.8608993426157, 795.5306369242146, 789.6604460082162, 792.1326147868104, 792.6512334572799, 792.6948124971899, 793.2028311546916, 824.8638974569219, 825.352098602597, 827.4869580859876, 828.4863384701493, 829.1087081387502, 825.6903661127077, 825.7068740597092, 826.0830478169228, 827.230675471811, 830.1490971753971, 600.198734689186, 600.7987324246383, 600.855794609295, 601.7382438639162, 602.1900543768625, 11664.6500604982, 11684.47419866108, 11732.53069877204, 11757.88242117585, 11767.117466189984, 10330.690079297634, 10521.684349469528, 10544.25667425826, 10578.259521833475, 10739.677809665722, 8312.8337433251, 8357.0, 8443.662253509852, 8521.10528394522, 8561.101084386175, 3245.7078862902217, 3272.100172452571, 3311.718503927169, 3323.96676033239, 3372.0558243691808, 37468.437973430424, 39305.41041884374, 44048.339274910904, 46396.07207855824, 46600.533994659956, 9834.0, 9927.553260103312, 10094.596216151418, 10360.740981475523, 10450.268481206243, 17608.950537548968, 17787.555311117067, 17870.0, 17934.91032544855, 18126.909365453088, 7026.578405295699, 7107.253738357398, 7122.394596459256, 7144.3212894774915, 7286.562806231643, 3686.3548878946076, 3789.374753165697, 3816.1985982943893, 3840.4815349927962, 3843.7501562398356, 2872.6409198850142, 2915.8104723192923, 2918.54762511811, 2921.576371426131, 2951.3064429858964, 501.26814850318215, 505.29511331692083, 510.35185314650926, 521.1895502493659, 524.5567495466324, 553.8864532770772, 563.132775525694, 565.7878295639135, 572.221778381401, 576.4466112531933, 6783.287754785775, 6858.142732158481, 6945.7221711132, 7083.5041547091205, 7333.266673332624, 528.5454509122152, 529.3674059498939, 535.2880668710683, 538.4454012367268, 544.3413469701626, 3412.692857642824, 3422.761312938215, 3431.3995050866497, 3470.1498132957586, 3480.077779388464, 51547.48452515427, 52089.95820083577, 53853.461465385626, 54674.453255467735, 54720.72639636856, 41468.585314146476, 44593.77703111464, 46205.7689711556, 46905.061898761836, 47048.764756176686, 37853.81073094672, 38792.80603596964, 39491.40762888559, 39604.2079158421, 40507.7974610131, 7702.884456733265, 7777.688892444239, 7922.841543169219, 7941.642626081955, 8093.8381232376205, 27876.30309242285, 28827.7117228825, 29021.85489072541, 29346.559801602565, 29382.0, 35605.0, 36995.815020924725, 39576.40635390529, 39716.40425393564, 40141.0, 9600.423974561549, 9644.987276335884, 9694.75763105928, 9699.515024248618, 9832.984238231289, 10625.9468702656, 10683.94658026705, 10697.0, 10706.571737130738, 10827.891721083004, 9873.259505537257, 9920.553575089283, 10063.69808905734, 10456.424896630759, 10484.790304194026, 10528.894711052792, 10631.362118272928, 10909.399983000694, 10932.453377331261, 11321.320720756452, 9825.459599722084, 9962.452065136196, 10084.14284785772, 10092.394456332644, 10400.73998150022, 8498.787530311793, 8788.34087443457, 8809.207171354608, 9106.95446522763, 9218.262538996998, 8839.602217900081, 8876.467411955304, 8906.510141942255, 8944.195022448012, 9014.774630634287], "value": 5691.9059300152085, "unit": "score"}], "name": "dromaeo_css", "value": 6323.019760579901, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 113.0, 114.0, 114.0, 126.0, 113.0, 112.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 134.0, 157.0, 198.0, 136.0, 162.0, 167.0, 134.0, 190.0, 134.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 168.0, 173.0, 163.0, 163.0, 166.0, 166.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 74.0, 175.0, 76.0, 75.0, 73.0, 74.0, 162.0, 78.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 163.0, 94.0, 96.0, 94.0, 144.0, 93.0, 94.0, 140.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 153.0, 148.0, 148.0, 149.0, 150.0, 150.0, 147.0, 148.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 97.0, 95.0, 97.0, 94.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 65.0, 70.0, 69.0, 65.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 83.0, 80.0, 81.0, 81.0, 81.0, 110.0, 80.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 144.0, 136.0, 155.0, 137.0, 135.0, 140.0, 145.0, 139.0, 141.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 182.0, 181.0, 186.0, 189.0, 181.0, 188.0, 181.0, 176.0], "value": 182.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 75.0, 75.0, 76.0, 80.0, 76.0, 74.0, 75.0, 77.0], "value": 75.3, "unit": "score"}], "name": "kraken", "value": 1617.8, "alertThreshold": 2.0}]} 22:53:55 INFO - Return code: 0 22:53:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:53:55 ERROR - # TBPL SUCCESS # 22:53:55 INFO - Running post-action listener: _resource_record_post_action 22:53:55 INFO - Running post-run listener: _resource_record_post_run 22:53:56 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 528113664; Read time: 8; Write time: 484872 22:53:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243879936; Read time: 0; Write time: 286720 22:53:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283635712; Read time: 8; Write time: 198152 22:53:56 INFO - Running post-run listener: _upload_blobber_files 22:53:56 INFO - Blob upload gear active. 22:53:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:53:56 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 22:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:53:56 INFO - (blobuploader) - INFO - Open directory for files ... 22:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:53:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:57 INFO - (blobuploader) - INFO - Done attempting. 22:53:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:53:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:58 INFO - (blobuploader) - INFO - Done attempting. 22:53:58 INFO - (blobuploader) - INFO - Iteration through files over. 22:53:58 INFO - Return code: 0 22:53:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:53:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:53:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c729a32758fb5694c527b0ed77bf665f0e16a6616f15124389a4f85507aa6eae5fa518796f52dfd579dc1cd5e1a4b192686d0eaba50e6640e681dce9182e451c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47fbaece73d89543edbfbe3fce7fd2cb5b189e6043e716526ee243c587f61d72fdc6d63b0b5b44a8e3c050f5e0baeca2c4e01fc2bf7ecf5c34df8876ee538418"} 22:53:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:53:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:53:58 INFO - Contents: 22:53:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c729a32758fb5694c527b0ed77bf665f0e16a6616f15124389a4f85507aa6eae5fa518796f52dfd579dc1cd5e1a4b192686d0eaba50e6640e681dce9182e451c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47fbaece73d89543edbfbe3fce7fd2cb5b189e6043e716526ee243c587f61d72fdc6d63b0b5b44a8e3c050f5e0baeca2c4e01fc2bf7ecf5c34df8876ee538418"} 22:53:58 INFO - Running post-run listener: copy_logs_to_upload_dir 22:53:58 INFO - Copying logs to upload dir... 22:53:58 INFO - mkdir: /builds/slave/test/build/upload/logs 22:53:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.043977 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-21 22:53:56.746419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 22:53:56.751522) ========= 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-1461298573.768321-1420507860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c729a32758fb5694c527b0ed77bf665f0e16a6616f15124389a4f85507aa6eae5fa518796f52dfd579dc1cd5e1a4b192686d0eaba50e6640e681dce9182e451c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47fbaece73d89543edbfbe3fce7fd2cb5b189e6043e716526ee243c587f61d72fdc6d63b0b5b44a8e3c050f5e0baeca2c4e01fc2bf7ecf5c34df8876ee538418"} build_url:https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c729a32758fb5694c527b0ed77bf665f0e16a6616f15124389a4f85507aa6eae5fa518796f52dfd579dc1cd5e1a4b192686d0eaba50e6640e681dce9182e451c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47fbaece73d89543edbfbe3fce7fd2cb5b189e6043e716526ee243c587f61d72fdc6d63b0b5b44a8e3c050f5e0baeca2c4e01fc2bf7ecf5c34df8876ee538418"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 22:53:56.783412) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:53:56.783743) ========= 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-1461298573.768321-1420507860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:53:56.865218) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 22:53:56.865596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 22:53:56.865994) ========= ========= Total master_lag: 0.17 =========