builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1453321926.87 results: success (0) buildid: 20160120115628 builduid: e5f3daf29bd245f98a39a3d41e0ca6f0 revision: 8fc9a5eeede3b4551dbcbf0a77fe40349914c83e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.872034) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.872498) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.872842) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005737 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.895137) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.895444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.909098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.909530) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.959468) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.960087) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.960927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:06.961381) ========= 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=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 12:32:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.1M=0s 2016-01-20 12:32:07 (84.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.341981 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:07.318243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:07.318726) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020546 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:07.369112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-20 12:32:07.369543) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8fc9a5eeede3b4551dbcbf0a77fe40349914c83e --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 8fc9a5eeede3b4551dbcbf0a77fe40349914c83e --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=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 12:32:07,900 truncating revision to first 12 chars 2016-01-20 12:32:07,900 Setting DEBUG logging. 2016-01-20 12:32:07,900 attempt 1/10 2016-01-20 12:32:07,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8fc9a5eeede3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 12:32:08,746 unpacking tar archive at: fx-team-8fc9a5eeede3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.108135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-20 12:32:08.491012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:08.491407) ========= echo 8fc9a5eeede3b4551dbcbf0a77fe40349914c83e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8fc9a5eeede3b4551dbcbf0a77fe40349914c83e'] 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=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8fc9a5eeede3b4551dbcbf0a77fe40349914c83e program finished with exit code 0 elapsedTime=0.004738 script_repo_revision: '8fc9a5eeede3b4551dbcbf0a77fe40349914c83e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:08.544817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:08.545353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:08.557440) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:08.558085) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/8fc9a5eeede3b4551dbcbf0a77fe40349914c83e ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 12:32:08.558813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-20 12:32:08.559303) ========= /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=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:32:09 INFO - MultiFileLogger online at 20160120 12:32:09 in /builds/slave/test 12:32:09 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 12:32:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:32:09 INFO - {'append_to_log': False, 12:32:09 INFO - 'base_work_dir': '/builds/slave/test', 12:32:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:32:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:32:09 INFO - 'branch': 'Fx-Team-Non-PGO', 12:32:09 INFO - 'buildbot_json_path': 'buildprops.json', 12:32:09 INFO - 'config_files': ('talos/linux_config.py',), 12:32:09 INFO - 'default_actions': ('clobber', 12:32:09 INFO - 'read-buildbot-config', 12:32:09 INFO - 'download-and-extract', 12:32:09 INFO - 'populate-webroot', 12:32:09 INFO - 'create-virtualenv', 12:32:09 INFO - 'install', 12:32:09 INFO - 'run-tests'), 12:32:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:32:09 INFO - 'download_minidump_stackwalk': True, 12:32:09 INFO - 'download_symbols': 'ondemand', 12:32:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:32:09 INFO - 'tooltool.py': '/tools/tooltool.py', 12:32:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:32:09 INFO - '/tools/misc-python/virtualenv.py')}, 12:32:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:32:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:32:09 INFO - 'installer_path': 'installer.exe', 12:32:09 INFO - 'log_level': 'info', 12:32:09 INFO - 'log_name': 'talos', 12:32:09 INFO - 'log_to_console': True, 12:32:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:32:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:32:09 INFO - 'opt_config_files': (), 12:32:09 INFO - 'pip_index': False, 12:32:09 INFO - 'sps_profile': False, 12:32:09 INFO - 'sps_profile_interval': 0, 12:32:09 INFO - 'suite': 'dromaeojs-e10s', 12:32:09 INFO - 'system_bits': '32', 12:32:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:32:09 INFO - 'title': 'talos-linux64-ix-034', 12:32:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:32:09 INFO - 'use_talos_json': True, 12:32:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:32:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:32:09 INFO - 'work_dir': 'build'} 12:32:09 INFO - ##### 12:32:09 INFO - ##### Running clobber step. 12:32:09 INFO - ##### 12:32:09 INFO - Running pre-action listener: _resource_record_pre_action 12:32:09 INFO - Running main action method: clobber 12:32:09 INFO - rmtree: /builds/slave/test/build 12:32:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:32:09 INFO - Running post-action listener: _resource_record_post_action 12:32:09 INFO - ##### 12:32:09 INFO - ##### Running read-buildbot-config step. 12:32:09 INFO - ##### 12:32:09 INFO - Running pre-action listener: _resource_record_pre_action 12:32:09 INFO - Running main action method: read_buildbot_config 12:32:09 INFO - Using buildbot properties: 12:32:09 INFO - { 12:32:09 INFO - "project": "", 12:32:09 INFO - "product": "firefox", 12:32:09 INFO - "script_repo_revision": "production", 12:32:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:32:09 INFO - "repository": "", 12:32:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:32:09 INFO - "buildid": "20160120115628", 12:32:09 INFO - "pgo_build": "False", 12:32:09 INFO - "basedir": "/builds/slave/test", 12:32:09 INFO - "buildnumber": 674, 12:32:09 INFO - "slavename": "talos-linux64-ix-034", 12:32:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:32:09 INFO - "platform": "ubuntu64_hw", 12:32:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:32:09 INFO - "branch": "fx-team", 12:32:09 INFO - "repo_path": "integration/fx-team", 12:32:09 INFO - "revision": "8fc9a5eeede3b4551dbcbf0a77fe40349914c83e", 12:32:09 INFO - "stage_platform": "linux64", 12:32:09 INFO - "builduid": "e5f3daf29bd245f98a39a3d41e0ca6f0", 12:32:09 INFO - "slavebuilddir": "test" 12:32:09 INFO - } 12:32:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:32:09 INFO - Running post-action listener: _resource_record_post_action 12:32:09 INFO - ##### 12:32:09 INFO - ##### Running download-and-extract step. 12:32:09 INFO - ##### 12:32:09 INFO - Running pre-action listener: _resource_record_pre_action 12:32:09 INFO - Running main action method: download_and_extract 12:32:09 INFO - mkdir: /builds/slave/test/build/tests 12:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:09 INFO - https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:32:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/test_packages.json 12:32:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/test_packages.json 12:32:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:32:10 INFO - Downloaded 1448 bytes. 12:32:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:32:10 INFO - Using the following test package requirements: 12:32:10 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:10 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:32:10 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:32:10 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:10 INFO - u'jsshell-linux-x86_64.zip'], 12:32:10 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:32:10 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:10 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:32:10 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:32:10 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:32:10 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:10 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:32:10 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:10 INFO - https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:32:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:32:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:32:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:32:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:32:11 INFO - Downloaded 21217723 bytes. 12:32:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:32:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:32:12 INFO - Return code: 0 12:32:12 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:12 INFO - https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:32:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:32:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:32:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:32:13 INFO - Downloaded 21217723 bytes. 12:32:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:32:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:32:15 INFO - Return code: 0 12:32: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')]} 12:32:15 INFO - https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:32:16 INFO - Downloaded 11132144 bytes. 12:32:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:32:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:32:16 INFO - Return code: 0 12:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:16 INFO - https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:32:17 INFO - Downloaded 54184786 bytes. 12:32:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:32:17 INFO - mkdir: /builds/slave/test/properties 12:32:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:32:17 INFO - Writing to file /builds/slave/test/properties/build_url 12:32:17 INFO - Contents: 12:32:17 INFO - build_url:https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:32:17 INFO - Running post-action listener: _resource_record_post_action 12:32:17 INFO - Running post-action listener: set_extra_try_arguments 12:32:17 INFO - ##### 12:32:17 INFO - ##### Running populate-webroot step. 12:32:17 INFO - ##### 12:32:17 INFO - Running pre-action listener: _resource_record_pre_action 12:32:17 INFO - Running main action method: populate_webroot 12:32:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:32:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:32:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:32:17 INFO - '--tppagecycles', 12:32:17 INFO - '7'], 12:32:17 INFO - 'tests': ['tsvgm']}}, 12:32:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:32:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:32:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:32:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:32:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:32:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:17 INFO - 'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:32:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:17 INFO - 'tests': ['damp', 'tps']}, 12:32:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:17 INFO - 'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['damp', 'tps']}, 12:32:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:32:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:32:17 INFO - 'other': {'tests': ['a11yr', 12:32:17 INFO - 'ts_paint', 12:32:17 INFO - 'tpaint', 12:32:17 INFO - 'sessionrestore', 12:32:17 INFO - 'sessionrestore_no_auto_restore']}, 12:32:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['a11yr', 12:32:17 INFO - 'ts_paint', 12:32:17 INFO - 'tpaint', 12:32:17 INFO - 'sessionrestore', 12:32:17 INFO - 'sessionrestore_no_auto_restore']}, 12:32:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['a11yr', 12:32:17 INFO - 'ts_paint', 12:32:17 INFO - 'tpaint', 12:32:17 INFO - 'sessionrestore', 12:32:17 INFO - 'sessionrestore_no_auto_restore']}, 12:32:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['a11yr', 12:32:17 INFO - 'ts_paint', 12:32:17 INFO - 'tpaint', 12:32:17 INFO - 'sessionrestore', 12:32:17 INFO - 'sessionrestore_no_auto_restore']}, 12:32:17 INFO - 'other_l64': {'tests': ['a11yr', 12:32:17 INFO - 'ts_paint', 12:32:17 INFO - 'tpaint', 12:32:17 INFO - 'sessionrestore', 12:32:17 INFO - 'sessionrestore_no_auto_restore']}, 12:32:17 INFO - 'other_nol64': {'tests': ['a11yr', 12:32:17 INFO - 'ts_paint', 12:32:17 INFO - 'tpaint', 12:32:17 INFO - 'sessionrestore', 12:32:17 INFO - 'sessionrestore_no_auto_restore']}, 12:32:17 INFO - 'svgr': {'tests': ['tsvgx', 12:32:17 INFO - 'tsvgr_opacity', 12:32:17 INFO - 'tart', 12:32:17 INFO - 'tscrollx', 12:32:17 INFO - 'cart']}, 12:32:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['tsvgx', 12:32:17 INFO - 'tsvgr_opacity', 12:32:17 INFO - 'tart', 12:32:17 INFO - 'tscrollx', 12:32:17 INFO - 'cart']}, 12:32:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:17 INFO - 'tests': ['tp5o']}, 12:32:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:17 INFO - 'talos_options': ['--e10s'], 12:32:17 INFO - 'tests': ['tp5o']}, 12:32:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:17 INFO - 'talos_options': ['--xperf_path', 12:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:32:17 INFO - 'tests': ['tp5n']}, 12:32:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:32:17 INFO - 'talos_options': ['--e10s', 12:32:17 INFO - '--xperf_path', 12:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:32:17 INFO - 'tests': ['tp5n']}}, 12:32:17 INFO - 'talos.zip': {'path': '', 12:32:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:32:17 INFO - Running post-action listener: _resource_record_post_action 12:32:17 INFO - ##### 12:32:17 INFO - ##### Running create-virtualenv step. 12:32:17 INFO - ##### 12:32:17 INFO - Running pre-action listener: _resource_record_pre_action 12:32:17 INFO - Running main action method: create_virtualenv 12:32:17 INFO - Creating virtualenv /builds/slave/test/build/venv 12:32:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:32:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:32:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:32:17 INFO - Using real prefix '/usr' 12:32:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:32:18 INFO - Installing distribute.............................................................................................................................................................................................done. 12:32:20 INFO - Installing pip.................done. 12:32:20 INFO - Return code: 0 12:32:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:20 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 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:32:20 INFO - Using env: {'DISPLAY': ':0', 12:32:20 INFO - 'HOME': '/home/cltbld', 12:32:20 INFO - 'LANG': 'en_US.UTF-8', 12:32:20 INFO - 'LANGUAGE': 'en_US:en', 12:32:20 INFO - 'LOGNAME': 'cltbld', 12:32:20 INFO - 'MAIL': '/var/mail/cltbld', 12:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:20 INFO - 'MOZ_NO_REMOTE': '1', 12:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:20 INFO - 'NO_EM_RESTART': '1', 12:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:20 INFO - 'PWD': '/builds/slave/test', 12:32:20 INFO - 'SHELL': '/bin/bash', 12:32:20 INFO - 'SHLVL': '1', 12:32:20 INFO - 'TERM': 'linux', 12:32:20 INFO - 'TMOUT': '86400', 12:32:20 INFO - 'USER': 'cltbld', 12:32:20 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:20 INFO - '_': '/tools/buildbot/bin/python'} 12:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:32:20 INFO - Cleaning up... 12:32:20 INFO - Return code: 0 12:32:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:20 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 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:32:20 INFO - Using env: {'DISPLAY': ':0', 12:32:20 INFO - 'HOME': '/home/cltbld', 12:32:20 INFO - 'LANG': 'en_US.UTF-8', 12:32:20 INFO - 'LANGUAGE': 'en_US:en', 12:32:20 INFO - 'LOGNAME': 'cltbld', 12:32:20 INFO - 'MAIL': '/var/mail/cltbld', 12:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:20 INFO - 'MOZ_NO_REMOTE': '1', 12:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:20 INFO - 'NO_EM_RESTART': '1', 12:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:20 INFO - 'PWD': '/builds/slave/test', 12:32:20 INFO - 'SHELL': '/bin/bash', 12:32:20 INFO - 'SHLVL': '1', 12:32:20 INFO - 'TERM': 'linux', 12:32:20 INFO - 'TMOUT': '86400', 12:32:20 INFO - 'USER': 'cltbld', 12:32:20 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:20 INFO - '_': '/tools/buildbot/bin/python'} 12:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:20 INFO - Downloading/unpacking psutil>=0.7.1 12:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:22 INFO - Installing collected packages: psutil 12:32:22 INFO - Running setup.py install for psutil 12:32:22 INFO - building 'psutil._psutil_linux' extension 12:32:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:32:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:32:22 INFO - building 'psutil._psutil_posix' extension 12:32:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:32:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:23 INFO - Successfully installed psutil 12:32:23 INFO - Cleaning up... 12:32:23 INFO - Return code: 0 12:32:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:23 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 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:32:23 INFO - Using env: {'DISPLAY': ':0', 12:32:23 INFO - 'HOME': '/home/cltbld', 12:32:23 INFO - 'LANG': 'en_US.UTF-8', 12:32:23 INFO - 'LANGUAGE': 'en_US:en', 12:32:23 INFO - 'LOGNAME': 'cltbld', 12:32:23 INFO - 'MAIL': '/var/mail/cltbld', 12:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:23 INFO - 'MOZ_NO_REMOTE': '1', 12:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:23 INFO - 'NO_EM_RESTART': '1', 12:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:23 INFO - 'PWD': '/builds/slave/test', 12:32:23 INFO - 'SHELL': '/bin/bash', 12:32:23 INFO - 'SHLVL': '1', 12:32:23 INFO - 'TERM': 'linux', 12:32:23 INFO - 'TMOUT': '86400', 12:32:23 INFO - 'USER': 'cltbld', 12:32:23 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:23 INFO - '_': '/tools/buildbot/bin/python'} 12:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:32:25 INFO - Installing collected packages: mozsystemmonitor 12:32:25 INFO - Running setup.py install for mozsystemmonitor 12:32:25 INFO - Successfully installed mozsystemmonitor 12:32:25 INFO - Cleaning up... 12:32:25 INFO - Return code: 0 12:32:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:25 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 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:32:25 INFO - Using env: {'DISPLAY': ':0', 12:32:25 INFO - 'HOME': '/home/cltbld', 12:32:25 INFO - 'LANG': 'en_US.UTF-8', 12:32:25 INFO - 'LANGUAGE': 'en_US:en', 12:32:25 INFO - 'LOGNAME': 'cltbld', 12:32:25 INFO - 'MAIL': '/var/mail/cltbld', 12:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:25 INFO - 'MOZ_NO_REMOTE': '1', 12:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:25 INFO - 'NO_EM_RESTART': '1', 12:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:25 INFO - 'PWD': '/builds/slave/test', 12:32:25 INFO - 'SHELL': '/bin/bash', 12:32:25 INFO - 'SHLVL': '1', 12:32:25 INFO - 'TERM': 'linux', 12:32:25 INFO - 'TMOUT': '86400', 12:32:25 INFO - 'USER': 'cltbld', 12:32:25 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:25 INFO - '_': '/tools/buildbot/bin/python'} 12:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:27 INFO - Downloading blobuploader-1.2.4.tar.gz 12:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:32:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:32:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:27 INFO - Downloading docopt-0.6.1.tar.gz 12:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:32:28 INFO - Installing collected packages: blobuploader, requests, docopt 12:32:28 INFO - Running setup.py install for blobuploader 12:32:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:32:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:32:28 INFO - Running setup.py install for requests 12:32:28 INFO - Running setup.py install for docopt 12:32:28 INFO - Successfully installed blobuploader requests docopt 12:32:28 INFO - Cleaning up... 12:32:28 INFO - Return code: 0 12:32:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32: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')]} 12:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32: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')]} 12:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:28 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 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:32:28 INFO - Using env: {'DISPLAY': ':0', 12:32:28 INFO - 'HOME': '/home/cltbld', 12:32:28 INFO - 'LANG': 'en_US.UTF-8', 12:32:28 INFO - 'LANGUAGE': 'en_US:en', 12:32:28 INFO - 'LOGNAME': 'cltbld', 12:32:28 INFO - 'MAIL': '/var/mail/cltbld', 12:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:28 INFO - 'MOZ_NO_REMOTE': '1', 12:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:28 INFO - 'NO_EM_RESTART': '1', 12:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:28 INFO - 'PWD': '/builds/slave/test', 12:32:28 INFO - 'SHELL': '/bin/bash', 12:32:28 INFO - 'SHLVL': '1', 12:32:28 INFO - 'TERM': 'linux', 12:32:28 INFO - 'TMOUT': '86400', 12:32:28 INFO - 'USER': 'cltbld', 12:32:28 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:28 INFO - '_': '/tools/buildbot/bin/python'} 12:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:32:28 INFO - Running setup.py (path:/tmp/pip-LxVluA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:32:28 INFO - Running setup.py (path:/tmp/pip-Ib7WYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:32:28 INFO - Running setup.py (path:/tmp/pip-NrbT_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:32:29 INFO - Running setup.py (path:/tmp/pip-tRe4cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:32:29 INFO - Running setup.py (path:/tmp/pip-J4aADE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:32:29 INFO - Running setup.py (path:/tmp/pip-d5YroO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:32:29 INFO - Running setup.py (path:/tmp/pip-DDLDg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:32:29 INFO - Running setup.py (path:/tmp/pip-X0yNAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:32:29 INFO - Running setup.py (path:/tmp/pip-6Sr_Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:32:29 INFO - Running setup.py (path:/tmp/pip-jw3Rf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:32:29 INFO - Running setup.py (path:/tmp/pip-_WfRE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:32:29 INFO - Running setup.py (path:/tmp/pip-MWoHgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:32:29 INFO - Running setup.py (path:/tmp/pip-mmAnhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:32:29 INFO - Running setup.py (path:/tmp/pip-KxXVZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:29 INFO - Running setup.py (path:/tmp/pip-ufiPEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:32:29 INFO - Running setup.py (path:/tmp/pip-5lTzYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:32:29 INFO - Running setup.py (path:/tmp/pip-1hWbQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:32:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:32:30 INFO - Running setup.py install for manifestparser 12:32:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Running setup.py install for mozcrash 12:32:30 INFO - Running setup.py install for mozdebug 12:32:30 INFO - Running setup.py install for mozdevice 12:32:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Running setup.py install for mozfile 12:32:30 INFO - Running setup.py install for mozhttpd 12:32:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Running setup.py install for mozinfo 12:32:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Running setup.py install for mozInstall 12:32:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:32:30 INFO - Running setup.py install for mozleak 12:32:30 INFO - Running setup.py install for mozlog 12:32:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:32:31 INFO - Running setup.py install for moznetwork 12:32:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:32:31 INFO - Running setup.py install for mozprocess 12:32:31 INFO - Running setup.py install for mozprofile 12:32:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:32:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:32:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:32:31 INFO - Running setup.py install for mozrunner 12:32:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:32:31 INFO - Running setup.py install for mozscreenshot 12:32:31 INFO - Running setup.py install for moztest 12:32:31 INFO - Running setup.py install for mozversion 12:32:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:32:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:32:31 INFO - Cleaning up... 12:32:31 INFO - Return code: 0 12:32:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:31 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 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:32:31 INFO - Using env: {'DISPLAY': ':0', 12:32:31 INFO - 'HOME': '/home/cltbld', 12:32:31 INFO - 'LANG': 'en_US.UTF-8', 12:32:31 INFO - 'LANGUAGE': 'en_US:en', 12:32:31 INFO - 'LOGNAME': 'cltbld', 12:32:31 INFO - 'MAIL': '/var/mail/cltbld', 12:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:31 INFO - 'MOZ_NO_REMOTE': '1', 12:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:31 INFO - 'NO_EM_RESTART': '1', 12:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:31 INFO - 'PWD': '/builds/slave/test', 12:32:31 INFO - 'SHELL': '/bin/bash', 12:32:31 INFO - 'SHLVL': '1', 12:32:31 INFO - 'TERM': 'linux', 12:32:31 INFO - 'TMOUT': '86400', 12:32:31 INFO - 'USER': 'cltbld', 12:32:31 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:31 INFO - '_': '/tools/buildbot/bin/python'} 12:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:32:32 INFO - Running setup.py (path:/tmp/pip-2SDBbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:32:32 INFO - Running setup.py (path:/tmp/pip-LlsX_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:32:32 INFO - Running setup.py (path:/tmp/pip-pFlney-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:32:32 INFO - Running setup.py (path:/tmp/pip-i6Gfp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:32:32 INFO - Running setup.py (path:/tmp/pip-peu84A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:32:32 INFO - Running setup.py (path:/tmp/pip-b1ho_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:32:32 INFO - Running setup.py (path:/tmp/pip-lIOamV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:32:32 INFO - Running setup.py (path:/tmp/pip-kPlZEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:32:32 INFO - Running setup.py (path:/tmp/pip-L6mHCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:32:32 INFO - Running setup.py (path:/tmp/pip-5okgYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:32:32 INFO - Running setup.py (path:/tmp/pip-tLglF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:32:32 INFO - Running setup.py (path:/tmp/pip-nZGDVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:32:32 INFO - Running setup.py (path:/tmp/pip-K94lYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:32:33 INFO - Running setup.py (path:/tmp/pip-ZN58Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:33 INFO - Running setup.py (path:/tmp/pip-AXcBhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:32:33 INFO - Running setup.py (path:/tmp/pip-DxbeSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:32:33 INFO - Running setup.py (path:/tmp/pip-fiKSR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:32:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:34 INFO - Downloading blessings-1.6.tar.gz 12:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:32:35 INFO - Installing collected packages: blessings 12:32:35 INFO - Running setup.py install for blessings 12:32:35 INFO - Successfully installed blessings 12:32:35 INFO - Cleaning up... 12:32:35 INFO - Return code: 0 12:32:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:32:35 INFO - Reading from file tmpfile_stdout 12:32:35 INFO - Current package versions: 12:32:35 INFO - argparse == 1.2.1 12:32:35 INFO - blessings == 1.6 12:32:35 INFO - blobuploader == 1.2.4 12:32:35 INFO - docopt == 0.6.1 12:32:35 INFO - manifestparser == 1.1 12:32:35 INFO - mozInstall == 1.12 12:32:35 INFO - mozcrash == 0.16 12:32:35 INFO - mozdebug == 0.1 12:32:35 INFO - mozdevice == 0.48 12:32:35 INFO - mozfile == 1.2 12:32:35 INFO - mozhttpd == 0.7 12:32:35 INFO - mozinfo == 0.9 12:32:35 INFO - mozleak == 0.1 12:32:35 INFO - mozlog == 3.1 12:32:35 INFO - moznetwork == 0.27 12:32:35 INFO - mozprocess == 0.22 12:32:35 INFO - mozprofile == 0.28 12:32:35 INFO - mozrunner == 6.11 12:32:35 INFO - mozscreenshot == 0.1 12:32:35 INFO - mozsystemmonitor == 0.0 12:32:35 INFO - moztest == 0.7 12:32:35 INFO - mozversion == 1.4 12:32:35 INFO - psutil == 3.1.1 12:32:35 INFO - requests == 1.2.3 12:32:35 INFO - wsgiref == 0.1.2 12:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:35 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 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:32:35 INFO - Using env: {'DISPLAY': ':0', 12:32:35 INFO - 'HOME': '/home/cltbld', 12:32:35 INFO - 'LANG': 'en_US.UTF-8', 12:32:35 INFO - 'LANGUAGE': 'en_US:en', 12:32:35 INFO - 'LOGNAME': 'cltbld', 12:32:35 INFO - 'MAIL': '/var/mail/cltbld', 12:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:35 INFO - 'MOZ_NO_REMOTE': '1', 12:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:35 INFO - 'NO_EM_RESTART': '1', 12:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:35 INFO - 'PWD': '/builds/slave/test', 12:32:35 INFO - 'SHELL': '/bin/bash', 12:32:35 INFO - 'SHLVL': '1', 12:32:35 INFO - 'TERM': 'linux', 12:32:35 INFO - 'TMOUT': '86400', 12:32:35 INFO - 'USER': 'cltbld', 12:32:35 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:35 INFO - '_': '/tools/buildbot/bin/python'} 12:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:32:35 INFO - Cleaning up... 12:32:35 INFO - Return code: 0 12:32:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:35 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 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:32:35 INFO - Using env: {'DISPLAY': ':0', 12:32:35 INFO - 'HOME': '/home/cltbld', 12:32:35 INFO - 'LANG': 'en_US.UTF-8', 12:32:35 INFO - 'LANGUAGE': 'en_US:en', 12:32:35 INFO - 'LOGNAME': 'cltbld', 12:32:35 INFO - 'MAIL': '/var/mail/cltbld', 12:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:35 INFO - 'MOZ_NO_REMOTE': '1', 12:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:35 INFO - 'NO_EM_RESTART': '1', 12:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:35 INFO - 'PWD': '/builds/slave/test', 12:32:35 INFO - 'SHELL': '/bin/bash', 12:32:35 INFO - 'SHLVL': '1', 12:32:35 INFO - 'TERM': 'linux', 12:32:35 INFO - 'TMOUT': '86400', 12:32:35 INFO - 'USER': 'cltbld', 12:32:35 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:35 INFO - '_': '/tools/buildbot/bin/python'} 12:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:35 INFO - Downloading/unpacking jsonschema 12:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:32:37 INFO - Downloading/unpacking functools32 (from jsonschema) 12:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:37 INFO - Downloading functools32-3.2.3-2.tar.gz 12:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:32:37 INFO - warning: no files found matching '*.txt' 12:32:37 INFO - no previously-included directories found matching 'build' 12:32:37 INFO - no previously-included directories found matching 'dist' 12:32:37 INFO - no previously-included directories found matching '.git*' 12:32:37 INFO - Installing collected packages: jsonschema, functools32 12:32:37 INFO - Running setup.py install for functools32 12:32:38 INFO - warning: no files found matching '*.txt' 12:32:38 INFO - no previously-included directories found matching 'build' 12:32:38 INFO - no previously-included directories found matching 'dist' 12:32:38 INFO - no previously-included directories found matching '.git*' 12:32:38 INFO - Successfully installed jsonschema functools32 12:32:38 INFO - Cleaning up... 12:32:38 INFO - Return code: 0 12:32:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:32: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')]} 12:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32: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')]} 12:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9c4e7af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, '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': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:32: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', 'flake8'] in /builds/slave/test/build 12:32: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 flake8 12:32:38 INFO - Using env: {'DISPLAY': ':0', 12:32:38 INFO - 'HOME': '/home/cltbld', 12:32:38 INFO - 'LANG': 'en_US.UTF-8', 12:32:38 INFO - 'LANGUAGE': 'en_US:en', 12:32:38 INFO - 'LOGNAME': 'cltbld', 12:32:38 INFO - 'MAIL': '/var/mail/cltbld', 12:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:38 INFO - 'MOZ_NO_REMOTE': '1', 12:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:38 INFO - 'NO_EM_RESTART': '1', 12:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:38 INFO - 'PWD': '/builds/slave/test', 12:32:38 INFO - 'SHELL': '/bin/bash', 12:32:38 INFO - 'SHLVL': '1', 12:32:38 INFO - 'TERM': 'linux', 12:32:38 INFO - 'TMOUT': '86400', 12:32:38 INFO - 'USER': 'cltbld', 12:32:38 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:38 INFO - '_': '/tools/buildbot/bin/python'} 12:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:38 INFO - Downloading/unpacking flake8 12:32: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 12:32: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 12:32: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 12:32: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 12:32: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 12:32: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 12:32:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:32:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:32:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:32:40 INFO - no previously-included directories found matching 'docs/_build' 12:32:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:32:40 INFO - Running setup.py install for pep8 12:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:32:40 INFO - no previously-included directories found matching 'docs/_build' 12:32:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:32:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:32:40 INFO - Cleaning up... 12:32:40 INFO - Return code: 0 12:32:40 INFO - Running post-action listener: _resource_record_post_action 12:32:40 INFO - Running post-action listener: _start_resource_monitoring 12:32:41 INFO - Starting resource monitoring. 12:32:41 INFO - ##### 12:32:41 INFO - ##### Running install step. 12:32:41 INFO - ##### 12:32:41 INFO - Running pre-action listener: _resource_record_pre_action 12:32:41 INFO - Running main action method: install 12:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:32:41 INFO - Reading from file tmpfile_stdout 12:32:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:32:41 INFO - Reading from file tmpfile_stdout 12:32:41 INFO - Output received: 12:32:41 INFO - Usage: mozinstall [options] installer 12:32:41 INFO - Options: 12:32:41 INFO - -h, --help show this help message and exit 12:32:41 INFO - -d DEST, --destination=DEST 12:32:41 INFO - Directory to install application into. [default: 12:32:41 INFO - "/builds/slave/test"] 12:32:41 INFO - --app=APP Application being installed. [default: firefox] 12:32:41 INFO - mkdir: /builds/slave/test/build/application 12:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:32:56 INFO - Reading from file tmpfile_stdout 12:32:56 INFO - Output received: 12:32:56 INFO - /builds/slave/test/build/application/firefox/firefox 12:32:56 INFO - Running post-action listener: _resource_record_post_action 12:32:56 INFO - ##### 12:32:56 INFO - ##### Running run-tests step. 12:32:56 INFO - ##### 12:32:56 INFO - Running pre-action listener: _resource_record_pre_action 12:32:56 INFO - Running main action method: run_tests 12:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:32:57 INFO - Python 2.7.3 12:32:57 INFO - Return code: 0 12:32:57 INFO - grabbing minidump binary from tooltool 12:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:57 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 0x11183d0>, '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 0x1083ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:32:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:32:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:32:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:32:57 INFO - Return code: 0 12:32:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:32:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:32:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:32:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:32:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:32:58 INFO - Return code: 0 12:32:58 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/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:32:58 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/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:32:58 INFO - Using env: {'DISPLAY': ':0', 12:32:58 INFO - 'HOME': '/home/cltbld', 12:32:58 INFO - 'LANG': 'en_US.UTF-8', 12:32:58 INFO - 'LANGUAGE': 'en_US:en', 12:32:58 INFO - 'LOGNAME': 'cltbld', 12:32:58 INFO - 'MAIL': '/var/mail/cltbld', 12:32:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:32:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:58 INFO - 'MOZ_NO_REMOTE': '1', 12:32:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:58 INFO - 'NO_EM_RESTART': '1', 12:32:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:58 INFO - 'PWD': '/builds/slave/test', 12:32:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:32:58 INFO - 'SHELL': '/bin/bash', 12:32:58 INFO - 'SHLVL': '1', 12:32:58 INFO - 'TERM': 'linux', 12:32:58 INFO - 'TMOUT': '86400', 12:32:58 INFO - 'USER': 'cltbld', 12:32:58 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229', 12:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:58 INFO - '_': '/tools/buildbot/bin/python'} 12:32:58 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/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:32:58 INFO - mozversion application_buildid: 20160120115628 12:32:58 INFO - mozversion application_changeset: 8fc9a5eeede3b4551dbcbf0a77fe40349914c83e 12:32:58 INFO - mozversion application_display_name: Nightly 12:32:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:32:58 INFO - mozversion application_name: Firefox 12:32:58 INFO - mozversion application_remotingname: firefox 12:32:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:32:58 INFO - mozversion application_vendor: Mozilla 12:32:58 INFO - mozversion application_version: 46.0a1 12:32:58 INFO - mozversion platform_buildid: 20160120115628 12:32:58 INFO - mozversion platform_changeset: 8fc9a5eeede3b4551dbcbf0a77fe40349914c83e 12:32:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:32:58 INFO - mozversion platform_version: 46.0a1 12:32:58 INFO - using testdate: 1453321978 12:32:58 INFO - actual date: 1453321978 12:32:58 INFO - starting webserver on 'localhost:33934' 12:32:58 INFO - SUITE-START | Running 3 tests 12:32:58 INFO - TEST-START | dromaeo_css 12:32:58 INFO - operating with platform_type : linux_ 12:32:58 INFO - Initialising browser for dromaeo_css test... 12:32:58 INFO - TEST-INFO | started process 29728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppuOxiP/profile http://localhost:33934/getInfo.html) 12:33:02 INFO - PROCESS | 29728 | 12:33:02 INFO - PROCESS | 29728 | (process:29809): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:33:02 INFO - PROCESS | 29728 | __metrics Screen width/height:1600/1200 12:33:02 INFO - PROCESS | 29728 | colorDepth:24 12:33:02 INFO - PROCESS | 29728 | Browser inner width/height: 1024/697 12:33:02 INFO - PROCESS | 29728 | __metrics 12:33:03 INFO - PROCESS | 29728 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:33:04 INFO - TEST-INFO | 29728: exit 0 12:33:04 INFO - Browser initialized. 12:33:04 INFO - Running cycle 1/1 for dromaeo_css test... 12:33:04 INFO - TEST-INFO | started process 29858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppuOxiP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:04 INFO - PROCESS | 29858 | -- checkerboarding starts below -- 12:33:04 INFO - PROCESS | 29858 | RENDERTRACE 0.033118 rect red 0 0 10 10 // viewport 12:33:04 INFO - PROCESS | 29858 | RENDERTRACE 35.4858 rect brown 0 0 10 10 // page 12:33:04 INFO - PROCESS | 29858 | RENDERTRACE 35.5265 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 12:33:04 INFO - PROCESS | 29858 | Checkerboarded for 1 frames (50.4065 ms), 100 peak, 1 severity. 12:33:05 INFO - PROCESS | 29858 | 12:33:05 INFO - PROCESS | 29858 | (process:29916): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:33:15 INFO - PROCESS | 29858 | RSS: Main: 150695936 12:33:15 INFO - PROCESS | 29858 | 12:34:05 INFO - PROCESS | 29858 | 1453322045625 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:36:17 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:33934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33934/tests/dromaeo/cssquery-ext.html) 12:36:18 INFO - PROCESS | 29858 | RSS: Main: 154611712 12:36:18 INFO - PROCESS | 29858 | 12:39:20 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:33934/tests/dromaeo/cssquery-ext.html (next: http://localhost:33934/tests/dromaeo/cssquery-jquery.html) 12:39:20 INFO - PROCESS | 29858 | RSS: Main: 151404544 12:39:20 INFO - PROCESS | 29858 | 12:42:22 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:33934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33934/tests/dromaeo/cssquery-mootools.html) 12:42:23 INFO - PROCESS | 29858 | RSS: Main: 152535040 12:42:23 INFO - PROCESS | 29858 | 12:45:25 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:33934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33934/tests/dromaeo/cssquery-prototype.html) 12:45:25 INFO - PROCESS | 29858 | RSS: Main: 150618112 12:45:25 INFO - PROCESS | 29858 | 12:48:28 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:33934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33934/tests/dromaeo/cssquery-yui.html) 12:48:29 INFO - PROCESS | 29858 | RSS: Main: 150372352 12:48:29 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | Cycle 1(1): loaded http://localhost:33934/tests/dromaeo/cssquery-yui.html (next: http://localhost:33934/tests/dromaeo/cssquery-dojo.html) 12:51:31 INFO - PROCESS | 29858 | RSS: Main: 153600000 12:51:31 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | __start_tp_report 12:51:31 INFO - PROCESS | 29858 | _x_x_mozilla_page_load 12:51:31 INFO - PROCESS | 29858 | _x_x_mozilla_page_load_details 12:51:31 INFO - PROCESS | 29858 | |i|pagename|runs| 12:51:31 INFO - PROCESS | 29858 | |0;dojo.html;2564.9230523084307;2575.0858445251924;2605.2184344696598;2617.7120516743157;2627.6189952456893;4398.274284743014;4454.510003899569;4458.464984201896;4499.257622492289;4523.615492683121;4448.488423831261;4452.3544086107495;4473.910521789562;4476.597106260436;4504.144212599604;3896.707746918978;4061.512618485786;4120.835166593348;4136;4184.3305071188615;4123;4174.958250417488;4182.142660754538;4186.476690413699;4205.179989901971;3955.0507878109192;4008.318585840414;4078.6737061035046;4140.91718165638;4159.563245859172;4073.7555746655294;4098.282800509899;4107.527634322061;4141;4142.150859073882;4031.657309128728;4090.4886889138857;4090.529589097262;4110.506739191286;4134.421181034658;4308.956910430887;4360.542143074963;4407.427034485497;4409.801558929824;4441.977790111061;4768.976155119202;4788.209945359012;4794.2808578713475;4805.111054454937;4805.591524720403;4634.606058485033;4689.484156742756;4761.785719642589;4762.452317983441;4794.280857871312;4405.074934263808;4431.40176076232;4441.644668426518;4472.955270447319;4473.686841921034;4867.367242258484;4896.853094407103;4902.730349830794;4911.0423467424225;4953.777080031407;4660.906781864343;4662.090892275974;4707.882302942454;4716.811327546929;4725.4565724941385;4819.95180048195;4824.962633033914;4830.2996065571;4840.080384726891;4869.975650121727;4773.665843390999;4774.737389443614;4775.116603428377;4779.330893674888;4819.59033482158;4692.601128904013;4698.765061746899;4765.69023013503;4771.188897887368;4776.426828780499;4040.8585699500377;4044.2315959967514;4060.573639767782;4066.024154203029;4073.450084238649;3572.5891522474726;3573.8927832165077;3577.4454959481322;3594.7483676142942;3619.692326152254;4155.625993660585;4176.1230141669985;4212.978935105366;4228.556001619847;4244.957550424456;4810.182269014276;4820.204666230033;4829.613630909589;4830.782614782343;4862.8784280392565;4055.8174882130374;4186.434831297796;4193.706440549193;4208.158368326347;4215.78921053946;4250.53244143144;4261.765602891809;4285.121550082225;4290.334998075304;4338.826446942087;4584.15193189261;4599.448066232074;4609.193391156534;4614.630829533629;4654.4414670239785;4791;4817.108834865421;4850.95149048505;4861.902761944671;4862.319275301531;4530.932036019528;4588.334691469651;4593.766529276246;4593.977030114828;4645.349651048923;4708.364370809897;4734.952650473589;4742.66801323904;4753.976230118966;4786.210275304536;4689.109069276827;4769.260764581357;4811.9518804811505;4814.446338670958;4827.61379089679;4674.579287864109;4689.366935463669;4700.130475861976;4709.764511774466;4733.573978341966;4638.234691275901;4686.086213188396;4690.038542098793;4695.22528782747;4738.573528382462;4424.690271680952;4480.193565158303;4511.5262897396615;4556.954430455653;4587.7017993830295;4732.408448943882;4735.668503204743;4760.642951778561;4767.737774422301;4788.209945358977;4633.258678611406;4651.953480465152;4664.86005419838;4672.229082201535;4719.716816990992 12:51:31 INFO - PROCESS | 29858 | |1;ext.html;487.264231011173;500.89731605020967;507.48490282363383;510.28305231150244;524.0279281932014;23683.76316236837;24243.636345454834;31180.376392472164;31566.684333156718;31629.209269768267;34116.488252676165;34484.827575862146;34569.30861382771;34576.1355966101;34636.82681586588;7591.506552074111;7730.420218483609;7749.5737734424865;7797.0643522777345;7807.297343239107;7506.662200200977;7615.885761713579;7621.466497345188;7633.351165150941;7638.427117966147;7567.470277080579;7612.391008719317;7749.7675069748;7842.451028428012;7848.72529461469;7673.769786906374;7758.8448231035345;7770;7820.100688420847;7827.021622297184;7552.66013029415;7744.574048427335;7767.223277672244;7770.57261850598;7772.7668169954995;35223.29553408943;35725.10687232814;35850;35963;36055;2637.525245455817;2746.258510202234;2831.348789778342;2870.2967772895568;2884.336602581418;27401.86299068512;27735.167944961682;27935.30161745952;27946.441071178666;28001.719982800318;3472.218750781054;3488.372093023255;3516.578010638714;3550.414181660023;3580.946285805715;234142;238726.8063659688;238953;239083.99999999825;239603;49027.50972490301;49230;49548.25677614839;49657.50342496529;49667.75166124218;50818.745906270975;50914.74542627263;57640.42359576435;58400.415995839496;58496;13064.934675326562;13066.608001759962;13078.869211307956;13128.409221585052;13222.801657975138;10225.181985441146;10237.43694096817;10292;10294.639687610897;10312.793744125076;18093.547661308574;18346.724799128024;18389.90805045993;18406.447806565826;18424.631507369777;7406.518576292524;7724.343430808444;7823.921760782319;7849.764507064797;7856.292933635886;865.4807115730637;885.1148851148852;886.3042511628341;890.8396488632109;971.8590804333332;25289.747102528738;25637.61543576848;25716.871415642803;25752.484950300888;25848;917.1470532404794;950.5057370167474;962.3215632978734;964.4309857184295;1038.050184081572;12764.872351276368;12774.680632984064;12934.611961641165;13015.479380824661;15246.923765381101;297680;299445;301346;301743;301811;45660.315095273596;46040.7697961508;46256.3061554077;46313.07373852504;46380.3042954356;1199.9340036297913;1204.0427859851438;1218.056006594896;1218.6831423829867;1228.4410593180082;25969.22092337233;26867.86566067157;26968.730312697407;27259.454810904066;27326.45347093087;40519.79740101399;41233.79383103185;41268;41408;41519.58480415157;195359;198858;199545;199631;199758;37031;41053;41777.37333940054;42083.7895810519;42138.78930605327;36333.273334532634;36920;37291;37693;37775.24449511049;36983.815080924425;37774;37978.620213797505;38431;38510.42234366431;32075.518867217477;32127;32356.191095222806;34229.315413692086;34834.129146771535;32113;32307;34150.31699366048;34616.30767384689;34994.125146871535;25531.36171595725;26861.731382685924;26895.596566051918;27046.459070818866;27064.72935270622;22455.214067507557;22739;23044.539109218058;23157.768422315563;23180.18869339565 12:51:31 INFO - PROCESS | 29858 | |2;jquery.html;343.02067597010534;345.44728434504793;347.65755730605366;348.3277274859523;348.386839163073;10217.438040907748;10554.261201715883;13650.249236292;13863.722725545484;15049.623759406006;15160.166190859498;15309.617259568517;15644.217789110557;15902.694109354137;15995.84004159958;5076.390833100033;5473.863153421176;5628.577856660767;5660.2075709400715;5683.687397193153;4751.809927602892;5594.664320140784;5648.548116150719;5655.066913959192;5677.574181936371;5910.527157827363;6162.106494558287;6173.9073913891325;6441.420272175504;6451.032345148242;6032.15549823023;6061.242344706911;6097.969510152443;6453.935460645381;6488.740450381979;5681.687507187103;6133.172021777048;6177.474914632262;6202.534809889276;6218.626882387026;17862.821371786376;18286.817131828644;18473.538161545934;18743.156557954924;18775.906120469448;1846.1784505894882;1855.6567035098415;1876.652819228447;1927.2483731344787;1987.473319570315;12085.335306558136;12149.752295825301;12283.324417157053;12634.557790477289;12823;1744.877858549902;1886.6415381077688;1892.280933245358;1931.33368987699;1949.561348696546;51813;52037.73981130146;53209.46790532084;53258.47302979251;53548.73225633886;14385.85614143866;14650.926745366418;14651.267436628126;14669.706605867823;14705.117692938244;21148.47128821792;21252.78747212539;21294.36116916495;21450.141994320365;21493.78506214949;8296.170382961776;8382.16178382157;8443.746687599381;8457.450265732708;8458.619362128597;7005;7053.047838541834;7062.081929349151;7074.045003924507;7092.326229008236;7262.96368518154;7283.089613798275;7343.706251749977;7354.521956072838;7394.186639469654;1677.706401379778;1771.1675512509357;1777.5733823882433;2976.2440160305523;3188.6970737779875;850.7787975126512;856.5759948825247;887.6759982606432;891.9554022298859;920.6179435534312;14697.118172909659;14725.926370368294;15138.318775655121;15156.24218789056;15161.469348572968;396.2985515637306;407.0150236427852;420.7454490033547;823.1932705948085;886.7827382291251;5203.375594928632;5524.779008839601;5597.608167428322;5634.239377684042;5751.1085781703905;443655;445843;446927;449254;457419;62468.68765656143;62970.685146573975;64493.67753161204;65884.67057664681;66351;458.5483298950531;463.2634111762247;465.03737263864156;465.2741722912335;465.51121322611124;9703.708888733348;9795.461249631338;9810.901890980998;9889;9936;27090;27640.308992275353;27837.304067398476;29364.26589335198;30208.54687179738;36793.448098279085;37017.62982370142;37144;37160.62839371571;37437.81281093577;3093.8917137900066;3738.7569807962395;6200.56596038291;6233.625982441068;6267.905981410374;8316.501009939422;8562.657493700182;9448.196903263299;9678.177354924628;9701.417914925127;7974.760757177294;8106.108328084024;8231.835363292581;8246.752597422086;8298.751037468886;7295.927040729737;7965.840683186188;8325.95837020811;8495.787605309917;8574.31405487547;8444.451110677786;8461.32309415233;8727.694530691395;8758.781030474289;8957.641694332153;6522.315156908646;6722.226943901318;6773.695183716646;6794.9320506796275;6949;8697.260732837527;8790.296776257755;8815.382923195315;8863.601137948937;9020.503872287087 12:51:31 INFO - PROCESS | 29858 | |3;mootools.html;1319.861414551472;1323.749057141002;1388.4654408052897;1618.9190540472973;1626.056887005536;5820.330661973874;5937.910931336022;6494.610323380601;6660.700268487917;6700.195976482817;6380.361963803617;6525.477961763059;6561.212654481469;6563.573367731095;6573.5727177733415;1952.2776572668097;2000.7499062617173;2006.0571531380228;2006.859519833605;2009.909554070063;1948.6589846776828;1964.8329891959202;1973.0923775063416;1987.9701804472945;1989.7114918336833;1970.5960278142945;1976.9703454448195;1986.4239370582513;1990.5222746540871;1998.980010199894;2020.3534868841975;2022.9291974780886;2030.4111807575784;2031.837453003756;2036.4399790057705;1990.3133418970433;1991.890446025468;1996.9101390437465;1998.8400927925877;2012.2856385982911;6786.76246331376;6832.45340372774;6866.519343645947;6874.621895795729;6875.58746475208;3731.738778285521;3818.694504439638;3828.9042773930596;3839.8464061437508;3850.711196660234;2526.7473252674586;2532.189699296226;2561.8719064046722;2567.0117004953227;2598.9870050649624;799.4244144216156;810.9432339736162;819.4468733604853;820.5692011693849;828.892244008275;8529.573521323971;8582.828343433159;8604.956975215146;8607.354448416456;8646.827063458695;3466.791992480459;3469.809160496197;3514.929701406009;3533.2756784859043;3540.716742660581;7466.70133194677;7478.5138965967035;7508.0239568855695;7544.849103017909;7549.3583045440655;3909.9609003910164;3925.8429662813737;3933.174033453007;3933.5083114610675;3936.4292177634084;3084.290613158941;3150.8582113804478;3460.8961731148106;3578.856845726194;3604.2070744436182;3253;3255.4302996975907;3291.226561757985;3309.2885029718727;3313.7349012078976;1034.2811745836723;1050.8161071812556;1051.9263651544472;1054.3094273251033;1056.060106505211;1087.7602163610682;1105.5025238642643;1124.005255349022;1124.0951034417374;1146.3179408252076;6146.293176284785;6197.721102550396;6210.378962103844;6216.160818289473;6216.627002379872;986.4229425785852;1004.6282875336173;1014.2089170447063;1015.4922538730634;1032.3496197395743;5088.287639730441;5165.140549402212;5186.196139598368;5193.480651934777;5209.01028804526;7901.841963160705;8092.635831387602;8198.959005204935;8248.381371397048;8265.710700125466;7942.722004729807;8061.556614386265;8112.351011919032;8113.797155071053;8114.107448180695;6391.96804015977;6406.654602533427;6449.451796597248;6483.902741458976;6524.771632992823;6017.037274036134;6178.876422471615;6183.5671502994355;6198.318184999736;6216.409441103088;7123.715051397886;7303.744368947274;7383.889241661272;7388.852222955618;7447.627618618939;7465.6267186641535;7485.139208990818;7490.325870671666;7558.168601453725;7696.422768292288;5118.462561431145;5247.2129180623215;6013.879722405615;6071.119687645179;6104.20645316106;6040.09398590215;6106.969465152646;6107.206063211754;6134.6625935573975;6159.1377207190135;5757.683327416865;5775.653460792366;5874.882502350015;5886.146508756292;5961.701914904324;5652.63257888236;5823.70881455934;5865;5903.793367232126;5938.406159384027;5639.238702775237;5644.689542075225;5664.603477756517;5951.256092988377;6048.6975651218145;5564.916526252028;5565.972170139124;5608.85977850557;5619.185218143428;5626.943730562642;5638.097904335286;5700.116481945305;5734.684592347294;5744.109663002241;5759.798407055733 12:51:31 INFO - PROCESS | 29858 | |4;prototype.html;284.77218225419665;286.3642713176747;293.37511101354124;297.3102402426371;303.24492014882946;5507.421720719327;5577.330720313563;5591;5656.349519805223;5677.148427735841;5527.695976721278;5528.668279903209;5536.197251398545;5538.252335934648;5538.695371754552;4246.278132717438;4248.596383343593;4250.787460626972;4251.363225158306;4254.255505286563;4088.2028004539125;4183.686223533232;4186.246475634384;4189.664826813862;4193.706440549163;4118.19695159444;4135.31767258402;4135.958640413603;4140.979295103521;4143.274926887798;4110.177964407116;4129.215449064668;4141.979290103545;4148.191102734968;4160.396742472324;3592.604813470516;3616.2044350242904;3616.987243571804;3617.5116359291424;3629.6551827576336;5153.510416510463;5178.637495375326;5205.037068142406;5249.238860365225;5289.127293996486;4770.212914869043;4780.976095119537;4784.593309568656;4806.303086052503;4806.591439727592;5763.164341170549;5767.163761254595;5776.046952252873;5782.10377391505;5784.334801497797;3896.830950714774;3897.4738410314526;3900.1419687668667;3901.356276214421;3910.120222949842;5890.911636325459;6130.080487926802;6141.662208578527;6142.447179753844;6142.570020098595;4051.959480405217;4052.979735101306;4053.2298863215897;4053.7973101344814;4062.0657248832936;4112.568180341081;4116.320807066861;4121.402396652528;4122.72195619359;4135.545090040093;4705.811767529261;4761.619070474354;4769.523047695272;4785.928211076836;4789.95210047902;5652.2652055233375;5844.561657875676;5849.268841394825;5860.062390017577;5861.677607731615;1424.3875133692611;1455.468753904817;1459.7810328450817;1460.0801495058258;1463.3195564062762;935.7567032571444;942.0767647705151;948;958.9808203836023;960.9183219426287;5048.823291184791;5074.13739664258;5091.389033316026;5098.694078355236;5117.897642047138;6035.637861728311;6042.667653279024;6047.0627052806885;6047.395260473917;6053.182820319289;5075.3148324975655;5078.746062696924;5086;5090.0583392072585;5096.464871188546;3197.6322722887166;3221.6778322167597;3253.837308134584;3270.329582435595;3290.52287418323;5696.51579615729;5697.971510142423;5704.401037891044;5724.398938111438;5743.511801496836;6227.1282020517165;6237.064440333987;6412.551121421549;6415.518836087312;6421.903671444932;5750.971245143747;5752.07966725322;5767.942320576908;5772.740226689725;5779.2775903012125;6044.214252147369;6110.938890611037;6112.663803490851;6130.816075517741;6139.662318572521;5843.035899076604;5940.821775346746;5992.43071908168;5996.520278377632;5996.610220335664;5783.971080144573;5791.507721843691;5796.01467750475;5801.274840644919;5816.9127463088935;3940.0937784309194;3942.113024569449;3968.722189446711;3970.4838371011583;3973.4238535412783;5968.76124954997;6089.665068421279;6101.816945491642;6103.176071230327;6115.602485838406;5807.070868660994;5850.502707269759;5867.119932010062;5885.293764748087;5889.381614930542;5888.440598143169;5892.882142357214;5899.085641725539;5902.881942361215;5924.052151655715;5768.1347797828985;5768.942310577008;5777.22007528995;5777.7977770777825;5784.045632470764;5778.219940308005;5931.881362372815;5942.940570594239;5946.613470124428;5946.762129514771;5792.4497172768515;5795.33353664334;5804.303483581997;5806.1000544915605;5820.068788993741 12:51:31 INFO - PROCESS | 29858 | |5;yui.html;762.2301475509735;765.3226894198633;769.4383100336751;769.6728890221658;776.9456138070334;10879.292845965017;10949.178811589123;11089.667309980694;11171.1621628378;11236.719082022953;10872.347659140438;10895.618653347134;10935.179861510378;10947.233693641429;10969.616063437781;575.858914565932;586.9060950247962;729.678941265844;730.4083692209327;737.038165194421;734.7501849371213;734.9783800517285;741.103265049291;746.652806445003;748.0126233371951;769.896064031357;775.4339332287434;778.4200770426012;780.621398621668;783.1111688233867;761.0866959648444;764.2892110337384;768.7616838779968;770.8265640230959;771.8109063279476;573.7963023126772;575.6603603873692;581.8719881626035;582.196568735147;583.4398976982102;11177.608783692613;11201.551937922555;11216.887831121667;11218.102551795837;11229.719257018558;11548.942255288754;11892.762144757056;11924.403779810975;12004.279743215435;12291.07816913735;8831.425957312818;8935.240504557121;8940;8945.373823832335;8971.730848074569;3201.103690966533;3277.2789986202997;3302.2734998300334;3318.551995480603;3401.8809341672923;38323.23353532942;38601.806990965146;38669.613303866885;38675;39117.804410978046;9177.403468774508;9355.532223388804;9463.621455141854;9525.952370238243;9573.569189386495;15679.05925644465;15681.921590391976;15692.76460853088;15715.685686286439;15733.292001859943;6565.441937435276;6593.175853018372;6617.106690596804;6636.469082473391;6828.897566536506;3678.613745556678;3789.886303410902;3791.526059242595;3793.715471339661;3807.9428808567895;2629.198094581133;2652.7479889410474;2653.8673066346605;2657.109868194138;2661.2548486423834;478.22527505441406;479.2762927978707;480.23162939297544;481.0283227879664;484.6704241116075;516.2617457036474;529.2405398253442;538.9919151212735;543.858596764844;553.6152374099962;7276.927230727731;7323.450741194431;7411.518251313755;7521.323080922743;7647.541147531166;448.5514485514486;458.68809209737697;492.83936329943185;533.0644718519052;542.9158480435539;3322.7041453833026;3367.7137443317592;3422.39835724883;3567.6967457765863;3581.874634387836;44461.333080003824;45120.3231951521;45450.545494545295;45592.08815823665;47371;37983;38197.61802381996;40469;40488.59511404848;41209.587904121174;37953.40931813593;38806.41790373147;39422.21155576872;39791.20417591632;40431;7286.453515986216;7467;7551.811204719926;7754.263344982218;7932.0878099019355;27892.44215115727;29061;29432.411351772418;29629.407411852073;30194.69805301919;36522;36764;37287.81356093202;37925.24149516939;38071.61928380681;9539.284553658643;9606.759831004281;9617.278704097082;9685;10121.089101980857;9848.261380396356;9983.60065597368;10023.949880250551;10083.495825208856;10099.242556808416;9523.19052880513;9539.47532885698;9548.952255238679;9599.376040557341;9613.711588652352;9547.045295470398;9560.330776845833;9563.187129094105;9592.328537002342;9688.757781055248;9598;9637.469939153134;9642.95178524131;9698.175655069399;9713.125818676353;7557.584332861746;7693.269139431745;7880;8036.959815200887;8040.075391330072;8109.7161599343735;8181.222783835526;8201.876971845308;8313.16868313188;8338.207870252316 12:51:31 INFO - PROCESS | 29858 | __end_tp_report 12:51:31 INFO - PROCESS | 29858 | __start_cc_report 12:51:31 INFO - PROCESS | 29858 | _x_x_mozilla_cycle_collect,331 12:51:31 INFO - PROCESS | 29858 | __end_cc_report 12:51:31 INFO - PROCESS | 29858 | __startTimestamp1453323091730__endTimestamp 12:51:31 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | ------- Summary: start ------- 12:51:31 INFO - PROCESS | 29858 | Number of tests: 6 12:51:31 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | [#0] dojo.html Cycles:165 Average:4436.67 Median:4588.33 stddev:453.84 (9.9%) stddev-sans-first:430.83 12:51:31 INFO - PROCESS | 29858 | Values: 2564.9 2575.1 2605.2 2617.7 2627.6 4398.3 4454.5 4458.5 4499.3 4523.6 4448.5 4452.4 4473.9 4476.6 4504.1 3896.7 4061.5 4120.8 4136.0 4184.3 4123.0 4175.0 4182.1 4186.5 4205.2 3955.1 4008.3 4078.7 4140.9 4159.6 4073.8 4098.3 4107.5 4141.0 4142.2 4031.7 4090.5 4090.5 4110.5 4134.4 4309.0 4360.5 4407.4 4409.8 4442.0 4769.0 4788.2 4794.3 4805.1 4805.6 4634.6 4689.5 4761.8 4762.5 4794.3 4405.1 4431.4 4441.6 4473.0 4473.7 4867.4 4896.9 4902.7 4911.0 4953.8 4660.9 4662.1 4707.9 4716.8 4725.5 4820.0 4825.0 4830.3 4840.1 4870.0 4773.7 4774.7 4775.1 4779.3 4819.6 4692.6 4698.8 4765.7 4771.2 4776.4 4040.9 4044.2 4060.6 4066.0 4073.5 3572.6 3573.9 3577.4 3594.7 3619.7 4155.6 4176.1 4213.0 4228.6 4245.0 4810.2 4820.2 4829.6 4830.8 4862.9 4055.8 4186.4 4193.7 4208.2 4215.8 4250.5 4261.8 4285.1 4290.3 4338.8 4584.2 4599.4 4609.2 4614.6 4654.4 4791.0 4817.1 4851.0 4861.9 4862.3 4530.9 4588.3 4593.8 4594.0 4645.3 4708.4 4735.0 4742.7 4754.0 4786.2 4689.1 4769.3 4812.0 4814.4 4827.6 4674.6 4689.4 4700.1 4709.8 4733.6 4638.2 4686.1 4690.0 4695.2 4738.6 4424.7 4480.2 4511.5 4557.0 4587.7 4732.4 4735.7 4760.6 4767.7 4788.2 4633.3 4652.0 4664.9 4672.2 4719.7 12:51:31 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | [#1] ext.html Cycles:180 Average:40325.90 Median:19161.25 stddev:65110.77 (339.8%) stddev-sans-first:65224.71 12:51:31 INFO - PROCESS | 29858 | Values: 487.3 500.9 507.5 510.3 524.0 23683.8 24243.6 31180.4 31566.7 31629.2 34116.5 34484.8 34569.3 34576.1 34636.8 7591.5 7730.4 7749.6 7797.1 7807.3 7506.7 7615.9 7621.5 7633.4 7638.4 7567.5 7612.4 7749.8 7842.5 7848.7 7673.8 7758.8 7770.0 7820.1 7827.0 7552.7 7744.6 7767.2 7770.6 7772.8 35223.3 35725.1 35850.0 35963.0 36055.0 2637.5 2746.3 2831.3 2870.3 2884.3 27401.9 27735.2 27935.3 27946.4 28001.7 3472.2 3488.4 3516.6 3550.4 3580.9 234142.0 238726.8 238953.0 239084.0 239603.0 49027.5 49230.0 49548.3 49657.5 49667.8 50818.7 50914.7 57640.4 58400.4 58496.0 13064.9 13066.6 13078.9 13128.4 13222.8 10225.2 10237.4 10292.0 10294.6 10312.8 18093.5 18346.7 18389.9 18406.4 18424.6 7406.5 7724.3 7823.9 7849.8 7856.3 865.5 885.1 886.3 890.8 971.9 25289.7 25637.6 25716.9 25752.5 25848.0 917.1 950.5 962.3 964.4 1038.1 12764.9 12774.7 12934.6 13015.5 15246.9 297680.0 299445.0 301346.0 301743.0 301811.0 45660.3 46040.8 46256.3 46313.1 46380.3 1199.9 1204.0 1218.1 1218.7 1228.4 25969.2 26867.9 26968.7 27259.5 27326.5 40519.8 41233.8 41268.0 41408.0 41519.6 195359.0 198858.0 199545.0 199631.0 199758.0 37031.0 41053.0 41777.4 42083.8 42138.8 36333.3 36920.0 37291.0 37693.0 37775.2 36983.8 37774.0 37978.6 38431.0 38510.4 32075.5 32127.0 32356.2 34229.3 34834.1 32113.0 32307.0 34150.3 34616.3 34994.1 25531.4 26861.7 26895.6 27046.5 27064.7 22455.2 22739.0 23044.5 23157.8 23180.2 12:51:31 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | [#2] jquery.html Cycles:180 Average:24227.56 Median:5596.14 stddev:73234.56 (1308.7%) stddev-sans-first:73418.05 12:51:31 INFO - PROCESS | 29858 | Values: 343.0 345.4 347.7 348.3 348.4 10217.4 10554.3 13650.2 13863.7 15049.6 15160.2 15309.6 15644.2 15902.7 15995.8 5076.4 5473.9 5628.6 5660.2 5683.7 4751.8 5594.7 5648.5 5655.1 5677.6 5910.5 6162.1 6173.9 6441.4 6451.0 6032.2 6061.2 6098.0 6453.9 6488.7 5681.7 6133.2 6177.5 6202.5 6218.6 17862.8 18286.8 18473.5 18743.2 18775.9 1846.2 1855.7 1876.7 1927.2 1987.5 12085.3 12149.8 12283.3 12634.6 12823.0 1744.9 1886.6 1892.3 1931.3 1949.6 51813.0 52037.7 53209.5 53258.5 53548.7 14385.9 14650.9 14651.3 14669.7 14705.1 21148.5 21252.8 21294.4 21450.1 21493.8 8296.2 8382.2 8443.7 8457.5 8458.6 7005.0 7053.0 7062.1 7074.0 7092.3 7263.0 7283.1 7343.7 7354.5 7394.2 1677.7 1771.2 1777.6 2976.2 3188.7 850.8 856.6 887.7 892.0 920.6 14697.1 14725.9 15138.3 15156.2 15161.5 396.3 407.0 420.7 823.2 886.8 5203.4 5524.8 5597.6 5634.2 5751.1 443655.0 445843.0 446927.0 449254.0 457419.0 62468.7 62970.7 64493.7 65884.7 66351.0 458.5 463.3 465.0 465.3 465.5 9703.7 9795.5 9810.9 9889.0 9936.0 27090.0 27640.3 27837.3 29364.3 30208.5 36793.4 37017.6 37144.0 37160.6 37437.8 3093.9 3738.8 6200.6 6233.6 6267.9 8316.5 8562.7 9448.2 9678.2 9701.4 7974.8 8106.1 8231.8 8246.8 8298.8 7295.9 7965.8 8326.0 8495.8 8574.3 8444.5 8461.3 8727.7 8758.8 8957.6 6522.3 6722.2 6773.7 6794.9 6949.0 8697.3 8790.3 8815.4 8863.6 9020.5 12:51:31 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | [#3] mootools.html Cycles:180 Average:4648.70 Median:5682.36 stddev:2373.13 (41.8%) stddev-sans-first:2366.59 12:51:31 INFO - PROCESS | 29858 | Values: 1319.9 1323.7 1388.5 1618.9 1626.1 5820.3 5937.9 6494.6 6660.7 6700.2 6380.4 6525.5 6561.2 6563.6 6573.6 1952.3 2000.7 2006.1 2006.9 2009.9 1948.7 1964.8 1973.1 1988.0 1989.7 1970.6 1977.0 1986.4 1990.5 1999.0 2020.4 2022.9 2030.4 2031.8 2036.4 1990.3 1991.9 1996.9 1998.8 2012.3 6786.8 6832.5 6866.5 6874.6 6875.6 3731.7 3818.7 3828.9 3839.8 3850.7 2526.7 2532.2 2561.9 2567.0 2599.0 799.4 810.9 819.4 820.6 828.9 8529.6 8582.8 8605.0 8607.4 8646.8 3466.8 3469.8 3514.9 3533.3 3540.7 7466.7 7478.5 7508.0 7544.8 7549.4 3910.0 3925.8 3933.2 3933.5 3936.4 3084.3 3150.9 3460.9 3578.9 3604.2 3253.0 3255.4 3291.2 3309.3 3313.7 1034.3 1050.8 1051.9 1054.3 1056.1 1087.8 1105.5 1124.0 1124.1 1146.3 6146.3 6197.7 6210.4 6216.2 6216.6 986.4 1004.6 1014.2 1015.5 1032.3 5088.3 5165.1 5186.2 5193.5 5209.0 7901.8 8092.6 8199.0 8248.4 8265.7 7942.7 8061.6 8112.4 8113.8 8114.1 6392.0 6406.7 6449.5 6483.9 6524.8 6017.0 6178.9 6183.6 6198.3 6216.4 7123.7 7303.7 7383.9 7388.9 7447.6 7465.6 7485.1 7490.3 7558.2 7696.4 5118.5 5247.2 6013.9 6071.1 6104.2 6040.1 6107.0 6107.2 6134.7 6159.1 5757.7 5775.7 5874.9 5886.1 5961.7 5652.6 5823.7 5865.0 5903.8 5938.4 5639.2 5644.7 5664.6 5951.3 6048.7 5564.9 5566.0 5608.9 5619.2 5626.9 5638.1 5700.1 5734.7 5744.1 5759.8 12:51:31 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | [#4] prototype.html Cycles:180 Average:4807.98 Median:5558.01 stddev:1460.56 (26.3%) stddev-sans-first:1424.65 12:51:31 INFO - PROCESS | 29858 | Values: 284.8 286.4 293.4 297.3 303.2 5507.4 5577.3 5591.0 5656.3 5677.1 5527.7 5528.7 5536.2 5538.3 5538.7 4246.3 4248.6 4250.8 4251.4 4254.3 4088.2 4183.7 4186.2 4189.7 4193.7 4118.2 4135.3 4136.0 4141.0 4143.3 4110.2 4129.2 4142.0 4148.2 4160.4 3592.6 3616.2 3617.0 3617.5 3629.7 5153.5 5178.6 5205.0 5249.2 5289.1 4770.2 4781.0 4784.6 4806.3 4806.6 5763.2 5767.2 5776.0 5782.1 5784.3 3896.8 3897.5 3900.1 3901.4 3910.1 5890.9 6130.1 6141.7 6142.4 6142.6 4052.0 4053.0 4053.2 4053.8 4062.1 4112.6 4116.3 4121.4 4122.7 4135.5 4705.8 4761.6 4769.5 4785.9 4790.0 5652.3 5844.6 5849.3 5860.1 5861.7 1424.4 1455.5 1459.8 1460.1 1463.3 935.8 942.1 948.0 959.0 960.9 5048.8 5074.1 5091.4 5098.7 5117.9 6035.6 6042.7 6047.1 6047.4 6053.2 5075.3 5078.7 5086.0 5090.1 5096.5 3197.6 3221.7 3253.8 3270.3 3290.5 5696.5 5698.0 5704.4 5724.4 5743.5 6227.1 6237.1 6412.6 6415.5 6421.9 5751.0 5752.1 5767.9 5772.7 5779.3 6044.2 6110.9 6112.7 6130.8 6139.7 5843.0 5940.8 5992.4 5996.5 5996.6 5784.0 5791.5 5796.0 5801.3 5816.9 3940.1 3942.1 3968.7 3970.5 3973.4 5968.8 6089.7 6101.8 6103.2 6115.6 5807.1 5850.5 5867.1 5885.3 5889.4 5888.4 5892.9 5899.1 5902.9 5924.1 5768.1 5768.9 5777.2 5777.8 5784.0 5778.2 5931.9 5942.9 5946.6 5946.8 5792.4 5795.3 5804.3 5806.1 5820.1 12:51:31 INFO - PROCESS | 29858 | 12:51:31 INFO - PROCESS | 29858 | [#5] yui.html Cycles:180 Average:11506.67 Median:540.95 stddev:12846.14 (2374.7%) stddev-sans-first:12856.83 12:51:31 INFO - PROCESS | 29858 | Values: 762.2 765.3 769.4 769.7 776.9 10879.3 10949.2 11089.7 11171.2 11236.7 10872.3 10895.6 10935.2 10947.2 10969.6 575.9 586.9 729.7 730.4 737.0 734.8 735.0 741.1 746.7 748.0 769.9 775.4 778.4 780.6 783.1 761.1 764.3 768.8 770.8 771.8 573.8 575.7 581.9 582.2 583.4 11177.6 11201.6 11216.9 11218.1 11229.7 11548.9 11892.8 11924.4 12004.3 12291.1 8831.4 8935.2 8940.0 8945.4 8971.7 3201.1 3277.3 3302.3 3318.6 3401.9 38323.2 38601.8 38669.6 38675.0 39117.8 9177.4 9355.5 9463.6 9526.0 9573.6 15679.1 15681.9 15692.8 15715.7 15733.3 6565.4 6593.2 6617.1 6636.5 6828.9 3678.6 3789.9 3791.5 3793.7 3807.9 2629.2 2652.7 2653.9 2657.1 2661.3 478.2 479.3 480.2 481.0 484.7 516.3 529.2 539.0 543.9 553.6 7276.9 7323.5 7411.5 7521.3 7647.5 448.6 458.7 492.8 533.1 542.9 3322.7 3367.7 3422.4 3567.7 3581.9 44461.3 45120.3 45450.5 45592.1 47371.0 37983.0 38197.6 40469.0 40488.6 41209.6 37953.4 38806.4 39422.2 39791.2 40431.0 7286.5 7467.0 7551.8 7754.3 7932.1 27892.4 29061.0 29432.4 29629.4 30194.7 36522.0 36764.0 37287.8 37925.2 38071.6 9539.3 9606.8 9617.3 9685.0 10121.1 9848.3 9983.6 10023.9 10083.5 10099.2 9523.2 9539.5 9549.0 9599.4 9613.7 9547.0 9560.3 9563.2 9592.3 9688.8 9598.0 9637.5 9643.0 9698.2 9713.1 7557.6 7693.3 7880.0 8037.0 8040.1 8109.7 8181.2 8201.9 8313.2 8338.2 12:51:31 INFO - PROCESS | 29858 | -------- Summary: end -------- 12:51:31 INFO - PROCESS | 29858 | 12:51:32 INFO - TEST-INFO | 29858: exit 0 12:51:32 INFO - TEST-OK | dromaeo_css | took 1114210ms 12:51:32 INFO - TEST-START | kraken 12:51:32 INFO - operating with platform_type : linux_ 12:51:32 INFO - Initialising browser for kraken test... 12:51:32 INFO - TEST-INFO | started process 30098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptpN4LE/profile http://localhost:33934/getInfo.html) 12:51:36 INFO - PROCESS | 30098 | -- checkerboarding starts below -- 12:51:36 INFO - PROCESS | 30098 | RENDERTRACE 0.035076 rect red 0 0 1024 768 // viewport 12:51:36 INFO - PROCESS | 30098 | RENDERTRACE 299.437 rect brown 0 0 1024 768 // page 12:51:36 INFO - PROCESS | 30098 | RENDERTRACE 299.47 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 12:51:36 INFO - PROCESS | 30098 | Checkerboarded for 1 frames (299.662 ms), 786432 peak, 11283 severity. 12:51:36 INFO - PROCESS | 30098 | 12:51:36 INFO - PROCESS | 30098 | (process:30170): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:51:36 INFO - PROCESS | 30098 | __metrics Screen width/height:1600/1200 12:51:36 INFO - PROCESS | 30098 | colorDepth:24 12:51:36 INFO - PROCESS | 30098 | Browser inner width/height: 1024/697 12:51:36 INFO - PROCESS | 30098 | __metrics 12:51:37 INFO - PROCESS | 30098 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:51:37 INFO - TEST-INFO | 30098: exit 0 12:51:37 INFO - Browser initialized. 12:51:37 INFO - Running cycle 1/1 for kraken test... 12:51:38 INFO - TEST-INFO | started process 30219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptpN4LE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:38 INFO - PROCESS | 30219 | -- checkerboarding starts below -- 12:51:38 INFO - PROCESS | 30219 | RENDERTRACE 0.034959 rect red 0 0 10 10 // viewport 12:51:38 INFO - PROCESS | 30219 | RENDERTRACE 24.3014 rect brown 0 0 10 10 // page 12:51:38 INFO - PROCESS | 30219 | RENDERTRACE 24.3418 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 12:51:38 INFO - PROCESS | 30219 | Checkerboarded for 1 frames (24.4595 ms), 100 peak, 1 severity. 12:51:39 INFO - PROCESS | 30219 | 12:51:39 INFO - PROCESS | 30219 | (process:30274): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:51:50 INFO - PROCESS | 30219 | RSS: Main: 150175744 12:51:50 INFO - PROCESS | 30219 | 12:51:52 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33934/tests/kraken/driver.html?testName=audio-beat-detection) 12:51:53 INFO - PROCESS | 30219 | RSS: Main: 148885504 12:51:53 INFO - PROCESS | 30219 | 12:51:56 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33934/tests/kraken/driver.html?testName=audio-dft) 12:51:56 INFO - PROCESS | 30219 | RSS: Main: 152420352 12:51:56 INFO - PROCESS | 30219 | 12:51:59 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33934/tests/kraken/driver.html?testName=audio-fft) 12:52:00 INFO - PROCESS | 30219 | RSS: Main: 146350080 12:52:00 INFO - PROCESS | 30219 | 12:52:02 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33934/tests/kraken/driver.html?testName=audio-oscillator) 12:52:02 INFO - PROCESS | 30219 | RSS: Main: 146911232 12:52:02 INFO - PROCESS | 30219 | 12:52:05 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:52:05 INFO - PROCESS | 30219 | RSS: Main: 148201472 12:52:05 INFO - PROCESS | 30219 | 12:52:08 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33934/tests/kraken/driver.html?testName=imaging-darkroom) 12:52:09 INFO - PROCESS | 30219 | RSS: Main: 148504576 12:52:09 INFO - PROCESS | 30219 | 12:52:12 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33934/tests/kraken/driver.html?testName=imaging-desaturate) 12:52:13 INFO - PROCESS | 30219 | RSS: Main: 148189184 12:52:13 INFO - PROCESS | 30219 | 12:52:16 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33934/tests/kraken/driver.html?testName=json-parse-financial) 12:52:17 INFO - PROCESS | 30219 | RSS: Main: 148537344 12:52:17 INFO - PROCESS | 30219 | 12:52:18 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:52:19 INFO - PROCESS | 30219 | RSS: Main: 149471232 12:52:19 INFO - PROCESS | 30219 | 12:52:21 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33934/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:52:21 INFO - PROCESS | 30219 | RSS: Main: 148779008 12:52:21 INFO - PROCESS | 30219 | 12:52:24 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:52:24 INFO - PROCESS | 30219 | RSS: Main: 149200896 12:52:24 INFO - PROCESS | 30219 | 12:52:27 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:52:27 INFO - PROCESS | 30219 | RSS: Main: 149598208 12:52:27 INFO - PROCESS | 30219 | 12:52:30 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:52:31 INFO - PROCESS | 30219 | RSS: Main: 149135360 12:52:31 INFO - PROCESS | 30219 | 12:52:32 INFO - PROCESS | 30219 | Cycle 1(1): loaded http://localhost:33934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33934/tests/kraken/driver.html?testName=ai-astar) 12:52:33 INFO - PROCESS | 30219 | RSS: Main: 149401600 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | __start_tp_report 12:52:33 INFO - PROCESS | 30219 | _x_x_mozilla_page_load 12:52:33 INFO - PROCESS | 30219 | _x_x_mozilla_page_load_details 12:52:33 INFO - PROCESS | 30219 | |i|pagename|runs| 12:52:33 INFO - PROCESS | 30219 | |0;ai-astar;117;113;117;118;119;128;114;115;115;117 12:52:33 INFO - PROCESS | 30219 | |1;audio-beat-detection;152;135;159;168;137;168;152;139;171;134 12:52:33 INFO - PROCESS | 30219 | |2;audio-dft;163;164;166;163;166;170;163;164;162;162 12:52:33 INFO - PROCESS | 30219 | |3;audio-fft;75;75;74;75;74;140;75;75;75;75 12:52:33 INFO - PROCESS | 30219 | |4;audio-oscillator;98;98;134;99;99;97;141;97;99;135 12:52:33 INFO - PROCESS | 30219 | |5;imaging-gaussian-blur;110;110;110;110;110;111;110;110;110;111 12:52:33 INFO - PROCESS | 30219 | |6;imaging-darkroom;149;148;148;148;150;149;149;148;149;148 12:52:33 INFO - PROCESS | 30219 | |7;imaging-desaturate;97;98;98;96;97;97;97;97;97;96 12:52:33 INFO - PROCESS | 30219 | |8;json-parse-financial;71;71;76;73;72;73;72;71;85;69 12:52:33 INFO - PROCESS | 30219 | |9;json-stringify-tinderbox;70;69;68;68;68;69;69;69;68;68 12:52:33 INFO - PROCESS | 30219 | |10;stanford-crypto-aes;83;82;83;85;84;84;83;82;85;84 12:52:33 INFO - PROCESS | 30219 | |11;stanford-crypto-ccm;126;121;123;123;119;124;125;123;129;125 12:52:33 INFO - PROCESS | 30219 | |12;stanford-crypto-pbkdf2;137;150;149;147;149;142;148;162;154;137 12:52:33 INFO - PROCESS | 30219 | |13;stanford-crypto-sha256-iterative;71;72;71;73;71;74;74;73;75;71 12:52:33 INFO - PROCESS | 30219 | __end_tp_report 12:52:33 INFO - PROCESS | 30219 | __start_cc_report 12:52:33 INFO - PROCESS | 30219 | _x_x_mozilla_cycle_collect,780 12:52:33 INFO - PROCESS | 30219 | __end_cc_report 12:52:33 INFO - PROCESS | 30219 | __startTimestamp1453323153115__endTimestamp 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | ------- Summary: start ------- 12:52:33 INFO - PROCESS | 30219 | Number of tests: 14 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#0] ai-astar Cycles:10 Average:117.30 Median:117.00 stddev:4.19 (3.6%) stddev-sans-first:4.44 12:52:33 INFO - PROCESS | 30219 | Values: 117.0 113.0 117.0 118.0 119.0 128.0 114.0 115.0 115.0 117.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:155.50 stddev:14.63 (9.4%) stddev-sans-first:15.52 12:52:33 INFO - PROCESS | 30219 | Values: 152.0 135.0 159.0 168.0 137.0 168.0 152.0 139.0 171.0 134.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.45 (1.5%) stddev-sans-first:2.55 12:52:33 INFO - PROCESS | 30219 | Values: 163.0 164.0 166.0 163.0 166.0 170.0 163.0 164.0 162.0 162.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:20.63 (27.5%) stddev-sans-first:21.75 12:52:33 INFO - PROCESS | 30219 | Values: 75.0 75.0 74.0 75.0 74.0 140.0 75.0 75.0 75.0 75.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:98.00 stddev:18.71 (19.1%) stddev-sans-first:19.36 12:52:33 INFO - PROCESS | 30219 | Values: 98.0 98.0 134.0 99.0 99.0 97.0 141.0 97.0 99.0 135.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:52:33 INFO - PROCESS | 30219 | Values: 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 12:52:33 INFO - PROCESS | 30219 | Values: 149.0 148.0 148.0 148.0 150.0 149.0 149.0 148.0 149.0 148.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:52:33 INFO - PROCESS | 30219 | Values: 97.0 98.0 98.0 96.0 97.0 97.0 97.0 97.0 97.0 96.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#8] json-parse-financial Cycles:10 Average:73.30 Median:72.50 stddev:4.50 (6.2%) stddev-sans-first:4.69 12:52:33 INFO - PROCESS | 30219 | Values: 71.0 71.0 76.0 73.0 72.0 73.0 72.0 71.0 85.0 69.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 12:52:33 INFO - PROCESS | 30219 | Values: 70.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 68.0 68.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.08 (1.3%) stddev-sans-first:1.13 12:52:33 INFO - PROCESS | 30219 | Values: 83.0 82.0 83.0 85.0 84.0 84.0 83.0 82.0 85.0 84.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.50 stddev:2.74 (2.2%) stddev-sans-first:2.79 12:52:33 INFO - PROCESS | 30219 | Values: 126.0 121.0 123.0 123.0 119.0 124.0 125.0 123.0 129.0 125.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:149.00 stddev:7.56 (5.1%) stddev-sans-first:7.00 12:52:33 INFO - PROCESS | 30219 | Values: 137.0 150.0 149.0 147.0 149.0 142.0 148.0 162.0 154.0 137.0 12:52:33 INFO - PROCESS | 30219 | 12:52:33 INFO - PROCESS | 30219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.51 (2.1%) stddev-sans-first:1.50 12:52:33 INFO - PROCESS | 30219 | Values: 71.0 72.0 71.0 73.0 71.0 74.0 74.0 73.0 75.0 71.0 12:52:33 INFO - PROCESS | 30219 | -------- Summary: end -------- 12:52:33 INFO - PROCESS | 30219 | 12:52:34 INFO - TEST-INFO | 30219: exit 0 12:52:34 INFO - TEST-OK | kraken | took 61695ms 12:52:34 INFO - TEST-START | v8_7 12:52:34 INFO - operating with platform_type : linux_ 12:52:34 INFO - Initialising browser for v8_7 test... 12:52:34 INFO - TEST-INFO | started process 30502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFExYk/profile http://localhost:33934/getInfo.html) 12:52:37 INFO - PROCESS | 30502 | 12:52:37 INFO - PROCESS | 30502 | (process:30572): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:52:38 INFO - PROCESS | 30502 | __metrics Screen width/height:1600/1200 12:52:38 INFO - PROCESS | 30502 | colorDepth:24 12:52:38 INFO - PROCESS | 30502 | Browser inner width/height: 1024/697 12:52:38 INFO - PROCESS | 30502 | __metrics 12:52:39 INFO - PROCESS | 30502 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:52:40 INFO - TEST-INFO | 30502: exit 0 12:52:40 INFO - Browser initialized. 12:52:40 INFO - Running cycle 1/1 for v8_7 test... 12:52:40 INFO - TEST-INFO | started process 30622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFExYk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:40 INFO - PROCESS | 30622 | -- checkerboarding starts below -- 12:52:40 INFO - PROCESS | 30622 | RENDERTRACE 0.03834 rect red 0 0 10 10 // viewport 12:52:40 INFO - PROCESS | 30622 | RENDERTRACE 70.9631 rect brown 0 0 10 10 // page 12:52:40 INFO - PROCESS | 30622 | RENDERTRACE 70.9867 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 12:52:40 INFO - PROCESS | 30622 | Checkerboarded for 1 frames (75.4123 ms), 100 peak, 1 severity. 12:52:41 INFO - PROCESS | 30622 | 12:52:41 INFO - PROCESS | 30622 | (process:30678): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:52:52 INFO - PROCESS | 30622 | RSS: Main: 150478848 12:52:52 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | Cycle 1(1): loaded http://localhost:33934/tests/v8_7/run.html (next: http://localhost:33934/tests/v8_7/run.html) 12:53:14 INFO - PROCESS | 30622 | RSS: Main: 145121280 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | __start_tp_report 12:53:14 INFO - PROCESS | 30622 | _x_x_mozilla_page_load 12:53:14 INFO - PROCESS | 30622 | _x_x_mozilla_page_load_details 12:53:14 INFO - PROCESS | 30622 | |i|pagename|runs| 12:53:14 INFO - PROCESS | 30622 | |0;Richards;170.8233686368295 12:53:14 INFO - PROCESS | 30622 | |1;DeltaBlue;186.77624206200971 12:53:14 INFO - PROCESS | 30622 | |2;Encrypt;279.01785714285717 12:53:14 INFO - PROCESS | 30622 | |3;Decrypt;5261.780104712042 12:53:14 INFO - PROCESS | 30622 | |4;RayTrace;1109.8779134295228 12:53:14 INFO - PROCESS | 30622 | |5;Earley;736.3770250368188 12:53:14 INFO - PROCESS | 30622 | |6;Boyer;12650 12:53:14 INFO - PROCESS | 30622 | |7;RegExp;42808.51063829787 12:53:14 INFO - PROCESS | 30622 | |8;Splay;596.4497041420118 12:53:14 INFO - PROCESS | 30622 | |9;NavierStokes;4822.115384615385 12:53:14 INFO - PROCESS | 30622 | __end_tp_report 12:53:14 INFO - PROCESS | 30622 | __startTimestamp1453323194819__endTimestamp 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | ------- Summary: start ------- 12:53:14 INFO - PROCESS | 30622 | Number of tests: 10 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#0] Richards Cycles:1 Average:170.82 Median:170.82 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 170.8 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#1] DeltaBlue Cycles:1 Average:186.78 Median:186.78 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 186.8 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 279.0 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#3] Decrypt Cycles:1 Average:5261.78 Median:5261.78 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 5261.8 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 1109.9 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#5] Earley Cycles:1 Average:736.38 Median:736.38 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 736.4 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#6] Boyer Cycles:1 Average:12650.00 Median:12650.00 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 12650.0 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#7] RegExp Cycles:1 Average:42808.51 Median:42808.51 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 42808.5 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#8] Splay Cycles:1 Average:596.45 Median:596.45 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 596.4 12:53:14 INFO - PROCESS | 30622 | 12:53:14 INFO - PROCESS | 30622 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 12:53:14 INFO - PROCESS | 30622 | Values: 4822.1 12:53:14 INFO - PROCESS | 30622 | -------- Summary: end -------- 12:53:14 INFO - PROCESS | 30622 | 12:53:15 INFO - TEST-INFO | 30622: exit 0 12:53:15 INFO - TEST-OK | v8_7 | took 41669ms 12:53:15 INFO - SUITE-END | took 1217s 12:53:16 INFO - Completed test suite (00:20:18) 12:53:16 INFO - Working with test: dromaeo_css 12:53:16 INFO - Generating results file: dromaeo_css 12:53:16 INFO - Working with test: kraken 12:53:16 INFO - Generating results file: kraken 12:53:16 INFO - javascript benchmark 12:53:16 INFO - Working with test: v8_7 12:53:16 INFO - Generating results file: v8_7 12:53:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:53:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 12:53:16 INFO - process_Request line: dromaeo_css 6075.80 graph.html#tests=[[72,132,43]] 12:53:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:53:16 INFO - process_Request line: kraken 1549.10 graph.html#tests=[[232,132,43]] 12:53:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:53:16 INFO - process_Request line: v8_7 20074.17 graph.html#tests=[[230,132,43]] 12:53:16 INFO - RETURN: dromaeo_css: 6075.80 12:53:16 INFO - RETURN: kraken: 1549.10 12:53:16 INFO - RETURN: v8_7: 20074.17 12:53:16 INFO - javascript benchmark 12:53:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2564.9230523084307, 2575.0858445251924, 2605.2184344696598, 2617.7120516743157, 2627.6189952456893, 4398.274284743014, 4454.510003899569, 4458.464984201896, 4499.257622492289, 4523.615492683121, 4448.488423831261, 4452.3544086107495, 4473.910521789562, 4476.597106260436, 4504.144212599604, 3896.707746918978, 4061.512618485786, 4120.835166593348, 4136.0, 4184.3305071188615, 4123.0, 4174.958250417488, 4182.142660754538, 4186.476690413699, 4205.179989901971, 3955.0507878109192, 4008.318585840414, 4078.6737061035046, 4140.91718165638, 4159.563245859172, 4073.7555746655294, 4098.282800509899, 4107.527634322061, 4141.0, 4142.150859073882, 4031.657309128728, 4090.4886889138857, 4090.529589097262, 4110.506739191286, 4134.421181034658, 4308.956910430887, 4360.542143074963, 4407.427034485497, 4409.801558929824, 4441.977790111061, 4768.976155119202, 4788.209945359012, 4794.2808578713475, 4805.111054454937, 4805.591524720403, 4634.606058485033, 4689.484156742756, 4761.785719642589, 4762.452317983441, 4794.280857871312, 4405.074934263808, 4431.40176076232, 4441.644668426518, 4472.955270447319, 4473.686841921034, 4867.367242258484, 4896.853094407103, 4902.730349830794, 4911.0423467424225, 4953.777080031407, 4660.906781864343, 4662.090892275974, 4707.882302942454, 4716.811327546929, 4725.4565724941385, 4819.95180048195, 4824.962633033914, 4830.2996065571, 4840.080384726891, 4869.975650121727, 4773.665843390999, 4774.737389443614, 4775.116603428377, 4779.330893674888, 4819.59033482158, 4692.601128904013, 4698.765061746899, 4765.69023013503, 4771.188897887368, 4776.426828780499, 4040.8585699500377, 4044.2315959967514, 4060.573639767782, 4066.024154203029, 4073.450084238649, 3572.5891522474726, 3573.8927832165077, 3577.4454959481322, 3594.7483676142942, 3619.692326152254, 4155.625993660585, 4176.1230141669985, 4212.978935105366, 4228.556001619847, 4244.957550424456, 4810.182269014276, 4820.204666230033, 4829.613630909589, 4830.782614782343, 4862.8784280392565, 4055.8174882130374, 4186.434831297796, 4193.706440549193, 4208.158368326347, 4215.78921053946, 4250.53244143144, 4261.765602891809, 4285.121550082225, 4290.334998075304, 4338.826446942087, 4584.15193189261, 4599.448066232074, 4609.193391156534, 4614.630829533629, 4654.4414670239785, 4791.0, 4817.108834865421, 4850.95149048505, 4861.902761944671, 4862.319275301531, 4530.932036019528, 4588.334691469651, 4593.766529276246, 4593.977030114828, 4645.349651048923, 4708.364370809897, 4734.952650473589, 4742.66801323904, 4753.976230118966, 4786.210275304536, 4689.109069276827, 4769.260764581357, 4811.9518804811505, 4814.446338670958, 4827.61379089679, 4674.579287864109, 4689.366935463669, 4700.130475861976, 4709.764511774466, 4733.573978341966, 4638.234691275901, 4686.086213188396, 4690.038542098793, 4695.22528782747, 4738.573528382462, 4424.690271680952, 4480.193565158303, 4511.5262897396615, 4556.954430455653, 4587.7017993830295, 4732.408448943882, 4735.668503204743, 4760.642951778561, 4767.737774422301, 4788.209945358977, 4633.258678611406, 4651.953480465152, 4664.86005419838, 4672.229082201535, 4719.716816990992], "unit": "score", "name": "dojo.html", "value": 4408.954870554093}, {"lowerIsBetter": false, "replicates": [487.264231011173, 500.89731605020967, 507.48490282363383, 510.28305231150244, 524.0279281932014, 23683.76316236837, 24243.636345454834, 31180.376392472164, 31566.684333156718, 31629.209269768267, 34116.488252676165, 34484.827575862146, 34569.30861382771, 34576.1355966101, 34636.82681586588, 7591.506552074111, 7730.420218483609, 7749.5737734424865, 7797.0643522777345, 7807.297343239107, 7506.662200200977, 7615.885761713579, 7621.466497345188, 7633.351165150941, 7638.427117966147, 7567.470277080579, 7612.391008719317, 7749.7675069748, 7842.451028428012, 7848.72529461469, 7673.769786906374, 7758.8448231035345, 7770.0, 7820.100688420847, 7827.021622297184, 7552.66013029415, 7744.574048427335, 7767.223277672244, 7770.57261850598, 7772.7668169954995, 35223.29553408943, 35725.10687232814, 35850.0, 35963.0, 36055.0, 2637.525245455817, 2746.258510202234, 2831.348789778342, 2870.2967772895568, 2884.336602581418, 27401.86299068512, 27735.167944961682, 27935.30161745952, 27946.441071178666, 28001.719982800318, 3472.218750781054, 3488.372093023255, 3516.578010638714, 3550.414181660023, 3580.946285805715, 234142.0, 238726.8063659688, 238953.0, 239083.99999999825, 239603.0, 49027.50972490301, 49230.0, 49548.25677614839, 49657.50342496529, 49667.75166124218, 50818.745906270975, 50914.74542627263, 57640.42359576435, 58400.415995839496, 58496.0, 13064.934675326562, 13066.608001759962, 13078.869211307956, 13128.409221585052, 13222.801657975138, 10225.181985441146, 10237.43694096817, 10292.0, 10294.639687610897, 10312.793744125076, 18093.547661308574, 18346.724799128024, 18389.90805045993, 18406.447806565826, 18424.631507369777, 7406.518576292524, 7724.343430808444, 7823.921760782319, 7849.764507064797, 7856.292933635886, 865.4807115730637, 885.1148851148852, 886.3042511628341, 890.8396488632109, 971.8590804333332, 25289.747102528738, 25637.61543576848, 25716.871415642803, 25752.484950300888, 25848.0, 917.1470532404794, 950.5057370167474, 962.3215632978734, 964.4309857184295, 1038.050184081572, 12764.872351276368, 12774.680632984064, 12934.611961641165, 13015.479380824661, 15246.923765381101, 297680.0, 299445.0, 301346.0, 301743.0, 301811.0, 45660.315095273596, 46040.7697961508, 46256.3061554077, 46313.07373852504, 46380.3042954356, 1199.9340036297913, 1204.0427859851438, 1218.056006594896, 1218.6831423829867, 1228.4410593180082, 25969.22092337233, 26867.86566067157, 26968.730312697407, 27259.454810904066, 27326.45347093087, 40519.79740101399, 41233.79383103185, 41268.0, 41408.0, 41519.58480415157, 195359.0, 198858.0, 199545.0, 199631.0, 199758.0, 37031.0, 41053.0, 41777.37333940054, 42083.7895810519, 42138.78930605327, 36333.273334532634, 36920.0, 37291.0, 37693.0, 37775.24449511049, 36983.815080924425, 37774.0, 37978.620213797505, 38431.0, 38510.42234366431, 32075.518867217477, 32127.0, 32356.191095222806, 34229.315413692086, 34834.129146771535, 32113.0, 32307.0, 34150.31699366048, 34616.30767384689, 34994.125146871535, 25531.36171595725, 26861.731382685924, 26895.596566051918, 27046.459070818866, 27064.72935270622, 22455.214067507557, 22739.0, 23044.539109218058, 23157.768422315563, 23180.18869339565], "unit": "score", "name": "ext.html", "value": 16525.617533545483}, {"lowerIsBetter": false, "replicates": [343.02067597010534, 345.44728434504793, 347.65755730605366, 348.3277274859523, 348.386839163073, 10217.438040907748, 10554.261201715883, 13650.249236292, 13863.722725545484, 15049.623759406006, 15160.166190859498, 15309.617259568517, 15644.217789110557, 15902.694109354137, 15995.84004159958, 5076.390833100033, 5473.863153421176, 5628.577856660767, 5660.2075709400715, 5683.687397193153, 4751.809927602892, 5594.664320140784, 5648.548116150719, 5655.066913959192, 5677.574181936371, 5910.527157827363, 6162.106494558287, 6173.9073913891325, 6441.420272175504, 6451.032345148242, 6032.15549823023, 6061.242344706911, 6097.969510152443, 6453.935460645381, 6488.740450381979, 5681.687507187103, 6133.172021777048, 6177.474914632262, 6202.534809889276, 6218.626882387026, 17862.821371786376, 18286.817131828644, 18473.538161545934, 18743.156557954924, 18775.906120469448, 1846.1784505894882, 1855.6567035098415, 1876.652819228447, 1927.2483731344787, 1987.473319570315, 12085.335306558136, 12149.752295825301, 12283.324417157053, 12634.557790477289, 12823.0, 1744.877858549902, 1886.6415381077688, 1892.280933245358, 1931.33368987699, 1949.561348696546, 51813.0, 52037.73981130146, 53209.46790532084, 53258.47302979251, 53548.73225633886, 14385.85614143866, 14650.926745366418, 14651.267436628126, 14669.706605867823, 14705.117692938244, 21148.47128821792, 21252.78747212539, 21294.36116916495, 21450.141994320365, 21493.78506214949, 8296.170382961776, 8382.16178382157, 8443.746687599381, 8457.450265732708, 8458.619362128597, 7005.0, 7053.047838541834, 7062.081929349151, 7074.045003924507, 7092.326229008236, 7262.96368518154, 7283.089613798275, 7343.706251749977, 7354.521956072838, 7394.186639469654, 1677.706401379778, 1771.1675512509357, 1777.5733823882433, 2976.2440160305523, 3188.6970737779875, 850.7787975126512, 856.5759948825247, 887.6759982606432, 891.9554022298859, 920.6179435534312, 14697.118172909659, 14725.926370368294, 15138.318775655121, 15156.24218789056, 15161.469348572968, 396.2985515637306, 407.0150236427852, 420.7454490033547, 823.1932705948085, 886.7827382291251, 5203.375594928632, 5524.779008839601, 5597.608167428322, 5634.239377684042, 5751.1085781703905, 443655.0, 445843.0, 446927.0, 449254.0, 457419.0, 62468.68765656143, 62970.685146573975, 64493.67753161204, 65884.67057664681, 66351.0, 458.5483298950531, 463.2634111762247, 465.03737263864156, 465.2741722912335, 465.51121322611124, 9703.708888733348, 9795.461249631338, 9810.901890980998, 9889.0, 9936.0, 27090.0, 27640.308992275353, 27837.304067398476, 29364.26589335198, 30208.54687179738, 36793.448098279085, 37017.62982370142, 37144.0, 37160.62839371571, 37437.81281093577, 3093.8917137900066, 3738.7569807962395, 6200.56596038291, 6233.625982441068, 6267.905981410374, 8316.501009939422, 8562.657493700182, 9448.196903263299, 9678.177354924628, 9701.417914925127, 7974.760757177294, 8106.108328084024, 8231.835363292581, 8246.752597422086, 8298.751037468886, 7295.927040729737, 7965.840683186188, 8325.95837020811, 8495.787605309917, 8574.31405487547, 8444.451110677786, 8461.32309415233, 8727.694530691395, 8758.781030474289, 8957.641694332153, 6522.315156908646, 6722.226943901318, 6773.695183716646, 6794.9320506796275, 6949.0, 8697.260732837527, 8790.296776257755, 8815.382923195315, 8863.601137948937, 9020.503872287087], "unit": "score", "name": "jquery.html", "value": 7641.571500873208}, {"lowerIsBetter": false, "replicates": [1319.861414551472, 1323.749057141002, 1388.4654408052897, 1618.9190540472973, 1626.056887005536, 5820.330661973874, 5937.910931336022, 6494.610323380601, 6660.700268487917, 6700.195976482817, 6380.361963803617, 6525.477961763059, 6561.212654481469, 6563.573367731095, 6573.5727177733415, 1952.2776572668097, 2000.7499062617173, 2006.0571531380228, 2006.859519833605, 2009.909554070063, 1948.6589846776828, 1964.8329891959202, 1973.0923775063416, 1987.9701804472945, 1989.7114918336833, 1970.5960278142945, 1976.9703454448195, 1986.4239370582513, 1990.5222746540871, 1998.980010199894, 2020.3534868841975, 2022.9291974780886, 2030.4111807575784, 2031.837453003756, 2036.4399790057705, 1990.3133418970433, 1991.890446025468, 1996.9101390437465, 1998.8400927925877, 2012.2856385982911, 6786.76246331376, 6832.45340372774, 6866.519343645947, 6874.621895795729, 6875.58746475208, 3731.738778285521, 3818.694504439638, 3828.9042773930596, 3839.8464061437508, 3850.711196660234, 2526.7473252674586, 2532.189699296226, 2561.8719064046722, 2567.0117004953227, 2598.9870050649624, 799.4244144216156, 810.9432339736162, 819.4468733604853, 820.5692011693849, 828.892244008275, 8529.573521323971, 8582.828343433159, 8604.956975215146, 8607.354448416456, 8646.827063458695, 3466.791992480459, 3469.809160496197, 3514.929701406009, 3533.2756784859043, 3540.716742660581, 7466.70133194677, 7478.5138965967035, 7508.0239568855695, 7544.849103017909, 7549.3583045440655, 3909.9609003910164, 3925.8429662813737, 3933.174033453007, 3933.5083114610675, 3936.4292177634084, 3084.290613158941, 3150.8582113804478, 3460.8961731148106, 3578.856845726194, 3604.2070744436182, 3253.0, 3255.4302996975907, 3291.226561757985, 3309.2885029718727, 3313.7349012078976, 1034.2811745836723, 1050.8161071812556, 1051.9263651544472, 1054.3094273251033, 1056.060106505211, 1087.7602163610682, 1105.5025238642643, 1124.005255349022, 1124.0951034417374, 1146.3179408252076, 6146.293176284785, 6197.721102550396, 6210.378962103844, 6216.160818289473, 6216.627002379872, 986.4229425785852, 1004.6282875336173, 1014.2089170447063, 1015.4922538730634, 1032.3496197395743, 5088.287639730441, 5165.140549402212, 5186.196139598368, 5193.480651934777, 5209.01028804526, 7901.841963160705, 8092.635831387602, 8198.959005204935, 8248.381371397048, 8265.710700125466, 7942.722004729807, 8061.556614386265, 8112.351011919032, 8113.797155071053, 8114.107448180695, 6391.96804015977, 6406.654602533427, 6449.451796597248, 6483.902741458976, 6524.771632992823, 6017.037274036134, 6178.876422471615, 6183.5671502994355, 6198.318184999736, 6216.409441103088, 7123.715051397886, 7303.744368947274, 7383.889241661272, 7388.852222955618, 7447.627618618939, 7465.6267186641535, 7485.139208990818, 7490.325870671666, 7558.168601453725, 7696.422768292288, 5118.462561431145, 5247.2129180623215, 6013.879722405615, 6071.119687645179, 6104.20645316106, 6040.09398590215, 6106.969465152646, 6107.206063211754, 6134.6625935573975, 6159.1377207190135, 5757.683327416865, 5775.653460792366, 5874.882502350015, 5886.146508756292, 5961.701914904324, 5652.63257888236, 5823.70881455934, 5865.0, 5903.793367232126, 5938.406159384027, 5639.238702775237, 5644.689542075225, 5664.603477756517, 5951.256092988377, 6048.6975651218145, 5564.916526252028, 5565.972170139124, 5608.85977850557, 5619.185218143428, 5626.943730562642, 5638.097904335286, 5700.116481945305, 5734.684592347294, 5744.109663002241, 5759.798407055733], "unit": "score", "name": "mootools.html", "value": 3853.804914393138}, {"lowerIsBetter": false, "replicates": [284.77218225419665, 286.3642713176747, 293.37511101354124, 297.3102402426371, 303.24492014882946, 5507.421720719327, 5577.330720313563, 5591.0, 5656.349519805223, 5677.148427735841, 5527.695976721278, 5528.668279903209, 5536.197251398545, 5538.252335934648, 5538.695371754552, 4246.278132717438, 4248.596383343593, 4250.787460626972, 4251.363225158306, 4254.255505286563, 4088.2028004539125, 4183.686223533232, 4186.246475634384, 4189.664826813862, 4193.706440549163, 4118.19695159444, 4135.31767258402, 4135.958640413603, 4140.979295103521, 4143.274926887798, 4110.177964407116, 4129.215449064668, 4141.979290103545, 4148.191102734968, 4160.396742472324, 3592.604813470516, 3616.2044350242904, 3616.987243571804, 3617.5116359291424, 3629.6551827576336, 5153.510416510463, 5178.637495375326, 5205.037068142406, 5249.238860365225, 5289.127293996486, 4770.212914869043, 4780.976095119537, 4784.593309568656, 4806.303086052503, 4806.591439727592, 5763.164341170549, 5767.163761254595, 5776.046952252873, 5782.10377391505, 5784.334801497797, 3896.830950714774, 3897.4738410314526, 3900.1419687668667, 3901.356276214421, 3910.120222949842, 5890.911636325459, 6130.080487926802, 6141.662208578527, 6142.447179753844, 6142.570020098595, 4051.959480405217, 4052.979735101306, 4053.2298863215897, 4053.7973101344814, 4062.0657248832936, 4112.568180341081, 4116.320807066861, 4121.402396652528, 4122.72195619359, 4135.545090040093, 4705.811767529261, 4761.619070474354, 4769.523047695272, 4785.928211076836, 4789.95210047902, 5652.2652055233375, 5844.561657875676, 5849.268841394825, 5860.062390017577, 5861.677607731615, 1424.3875133692611, 1455.468753904817, 1459.7810328450817, 1460.0801495058258, 1463.3195564062762, 935.7567032571444, 942.0767647705151, 948.0, 958.9808203836023, 960.9183219426287, 5048.823291184791, 5074.13739664258, 5091.389033316026, 5098.694078355236, 5117.897642047138, 6035.637861728311, 6042.667653279024, 6047.0627052806885, 6047.395260473917, 6053.182820319289, 5075.3148324975655, 5078.746062696924, 5086.0, 5090.0583392072585, 5096.464871188546, 3197.6322722887166, 3221.6778322167597, 3253.837308134584, 3270.329582435595, 3290.52287418323, 5696.51579615729, 5697.971510142423, 5704.401037891044, 5724.398938111438, 5743.511801496836, 6227.1282020517165, 6237.064440333987, 6412.551121421549, 6415.518836087312, 6421.903671444932, 5750.971245143747, 5752.07966725322, 5767.942320576908, 5772.740226689725, 5779.2775903012125, 6044.214252147369, 6110.938890611037, 6112.663803490851, 6130.816075517741, 6139.662318572521, 5843.035899076604, 5940.821775346746, 5992.43071908168, 5996.520278377632, 5996.610220335664, 5783.971080144573, 5791.507721843691, 5796.01467750475, 5801.274840644919, 5816.9127463088935, 3940.0937784309194, 3942.113024569449, 3968.722189446711, 3970.4838371011583, 3973.4238535412783, 5968.76124954997, 6089.665068421279, 6101.816945491642, 6103.176071230327, 6115.602485838406, 5807.070868660994, 5850.502707269759, 5867.119932010062, 5885.293764748087, 5889.381614930542, 5888.440598143169, 5892.882142357214, 5899.085641725539, 5902.881942361215, 5924.052151655715, 5768.1347797828985, 5768.942310577008, 5777.22007528995, 5777.7977770777825, 5784.045632470764, 5778.219940308005, 5931.881362372815, 5942.940570594239, 5946.613470124428, 5946.762129514771, 5792.4497172768515, 5795.33353664334, 5804.303483581997, 5806.1000544915605, 5820.068788993741], "unit": "score", "name": "prototype.html", "value": 4327.742718372038}, {"lowerIsBetter": false, "replicates": [762.2301475509735, 765.3226894198633, 769.4383100336751, 769.6728890221658, 776.9456138070334, 10879.292845965017, 10949.178811589123, 11089.667309980694, 11171.1621628378, 11236.719082022953, 10872.347659140438, 10895.618653347134, 10935.179861510378, 10947.233693641429, 10969.616063437781, 575.858914565932, 586.9060950247962, 729.678941265844, 730.4083692209327, 737.038165194421, 734.7501849371213, 734.9783800517285, 741.103265049291, 746.652806445003, 748.0126233371951, 769.896064031357, 775.4339332287434, 778.4200770426012, 780.621398621668, 783.1111688233867, 761.0866959648444, 764.2892110337384, 768.7616838779968, 770.8265640230959, 771.8109063279476, 573.7963023126772, 575.6603603873692, 581.8719881626035, 582.196568735147, 583.4398976982102, 11177.608783692613, 11201.551937922555, 11216.887831121667, 11218.102551795837, 11229.719257018558, 11548.942255288754, 11892.762144757056, 11924.403779810975, 12004.279743215435, 12291.07816913735, 8831.425957312818, 8935.240504557121, 8940.0, 8945.373823832335, 8971.730848074569, 3201.103690966533, 3277.2789986202997, 3302.2734998300334, 3318.551995480603, 3401.8809341672923, 38323.23353532942, 38601.806990965146, 38669.613303866885, 38675.0, 39117.804410978046, 9177.403468774508, 9355.532223388804, 9463.621455141854, 9525.952370238243, 9573.569189386495, 15679.05925644465, 15681.921590391976, 15692.76460853088, 15715.685686286439, 15733.292001859943, 6565.441937435276, 6593.175853018372, 6617.106690596804, 6636.469082473391, 6828.897566536506, 3678.613745556678, 3789.886303410902, 3791.526059242595, 3793.715471339661, 3807.9428808567895, 2629.198094581133, 2652.7479889410474, 2653.8673066346605, 2657.109868194138, 2661.2548486423834, 478.22527505441406, 479.2762927978707, 480.23162939297544, 481.0283227879664, 484.6704241116075, 516.2617457036474, 529.2405398253442, 538.9919151212735, 543.858596764844, 553.6152374099962, 7276.927230727731, 7323.450741194431, 7411.518251313755, 7521.323080922743, 7647.541147531166, 448.5514485514486, 458.68809209737697, 492.83936329943185, 533.0644718519052, 542.9158480435539, 3322.7041453833026, 3367.7137443317592, 3422.39835724883, 3567.6967457765863, 3581.874634387836, 44461.333080003824, 45120.3231951521, 45450.545494545295, 45592.08815823665, 47371.0, 37983.0, 38197.61802381996, 40469.0, 40488.59511404848, 41209.587904121174, 37953.40931813593, 38806.41790373147, 39422.21155576872, 39791.20417591632, 40431.0, 7286.453515986216, 7467.0, 7551.811204719926, 7754.263344982218, 7932.0878099019355, 27892.44215115727, 29061.0, 29432.411351772418, 29629.407411852073, 30194.69805301919, 36522.0, 36764.0, 37287.81356093202, 37925.24149516939, 38071.61928380681, 9539.284553658643, 9606.759831004281, 9617.278704097082, 9685.0, 10121.089101980857, 9848.261380396356, 9983.60065597368, 10023.949880250551, 10083.495825208856, 10099.242556808416, 9523.19052880513, 9539.47532885698, 9548.952255238679, 9599.376040557341, 9613.711588652352, 9547.045295470398, 9560.330776845833, 9563.187129094105, 9592.328537002342, 9688.757781055248, 9598.0, 9637.469939153134, 9642.95178524131, 9698.175655069399, 9713.125818676353, 7557.584332861746, 7693.269139431745, 7880.0, 8036.959815200887, 8040.075391330072, 8109.7161599343735, 8181.222783835526, 8201.876971845308, 8313.16868313188, 8338.207870252316], "unit": "score", "name": "yui.html", "value": 5416.876024332046}], "name": "dromaeo_css", "value": 6075.802833033937}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 113.0, 117.0, 118.0, 119.0, 128.0, 114.0, 115.0, 115.0, 117.0], "unit": "score", "name": "ai-astar", "value": 117.3}, {"lowerIsBetter": true, "replicates": [152.0, 135.0, 159.0, 168.0, 137.0, 168.0, 152.0, 139.0, 171.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 166.0, 163.0, 166.0, 170.0, 163.0, 164.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 74.0, 75.0, 74.0, 140.0, 75.0, 75.0, 75.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 134.0, 99.0, 99.0, 97.0, 141.0, 97.0, 99.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 148.0, 148.0, 150.0, 149.0, 149.0, 148.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 98.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 76.0, 73.0, 72.0, 73.0, 72.0, 71.0, 85.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 73.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 85.0, 84.0, 84.0, 83.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [126.0, 121.0, 123.0, 123.0, 119.0, 124.0, 125.0, 123.0, 129.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [137.0, 150.0, 149.0, 147.0, 149.0, 142.0, 148.0, 162.0, 154.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 73.0, 71.0, 74.0, 74.0, 73.0, 75.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.5}], "name": "kraken", "value": 1549.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.8233686368295], "unit": "score", "name": "Richards", "value": 206.65790799999996}, {"lowerIsBetter": false, "replicates": [186.77624206200971], "unit": "score", "name": "DeltaBlue", "value": 353.9957719999998}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5261.780104712042], "unit": "score", "name": "Decrypt", "value": 50.58763283582091}, {"lowerIsBetter": false, "replicates": [1109.8779134295228], "unit": "score", "name": "RayTrace", "value": 666.7300889999998}, {"lowerIsBetter": false, "replicates": [736.3770250368188], "unit": "score", "name": "Earley", "value": 905.0567539999997}, {"lowerIsBetter": false, "replicates": [12650.0], "unit": "score", "name": "Boyer", "value": 52.684822134387325}, {"lowerIsBetter": false, "replicates": [42808.51063829787], "unit": "score", "name": "RegExp", "value": 21.280464711729604}, {"lowerIsBetter": false, "replicates": [596.4497041420118], "unit": "score", "name": "Splay", "value": 136.6267757936508}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20074.173756473665}]} 12:53:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20074.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1549.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6075.80"}}} 12:53:16 INFO - Return code: 0 12:53:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:53:16 INFO - # TBPL SUCCESS # 12:53:16 INFO - Running post-action listener: _resource_record_post_action 12:53:16 INFO - Running post-run listener: _resource_record_post_run 12:53:17 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 543723520; Read time: 0; Write time: 623368 12:53:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234160128; Read time: 0; Write time: 338956 12:53:17 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 309563392; Read time: 0; Write time: 284412 12:53:17 INFO - Running post-run listener: _upload_blobber_files 12:53:17 INFO - Blob upload gear active. 12:53:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:53:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:53:17 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'] 12:53:17 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 12:53:18 INFO - (blobuploader) - INFO - Open directory for files ... 12:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:19 INFO - (blobuploader) - INFO - Done attempting. 12:53:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:53:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:19 INFO - (blobuploader) - INFO - Done attempting. 12:53:19 INFO - (blobuploader) - INFO - Iteration through files over. 12:53:19 INFO - Return code: 0 12:53:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:53:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:53:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8aa2c0bf4f10fbf75b3c7017ba0cd0bc310594e7b6e01fe74acb1b8e6d7e7410d4ddfdc047bfc25e44513fccecc9969c82f1fe8150effeabac0ee62ec563667b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6664eb2e046fcabbfc50b99c85ce1381625c113d386cdd91e14e6b66052b3eccea0c16ca6f082567f1ca4fea55f8fcb8f60b5103def042fce7740f54855cad39"} 12:53:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:53:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:53:19 INFO - Contents: 12:53:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8aa2c0bf4f10fbf75b3c7017ba0cd0bc310594e7b6e01fe74acb1b8e6d7e7410d4ddfdc047bfc25e44513fccecc9969c82f1fe8150effeabac0ee62ec563667b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6664eb2e046fcabbfc50b99c85ce1381625c113d386cdd91e14e6b66052b3eccea0c16ca6f082567f1ca4fea55f8fcb8f60b5103def042fce7740f54855cad39"} 12:53:19 INFO - Running post-run listener: copy_logs_to_upload_dir 12:53:19 INFO - Copying logs to upload dir... 12:53:19 INFO - mkdir: /builds/slave/test/build/upload/logs 12:53:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.973601 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-20 12:53:19.550822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 12:53:19.554262) ========= 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=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 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/8aa2c0bf4f10fbf75b3c7017ba0cd0bc310594e7b6e01fe74acb1b8e6d7e7410d4ddfdc047bfc25e44513fccecc9969c82f1fe8150effeabac0ee62ec563667b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6664eb2e046fcabbfc50b99c85ce1381625c113d386cdd91e14e6b66052b3eccea0c16ca6f082567f1ca4fea55f8fcb8f60b5103def042fce7740f54855cad39"} build_url:https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/GEM2K2EiT-SSVgC-m-ya6w/artifacts/public/build/firefox-46.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/8aa2c0bf4f10fbf75b3c7017ba0cd0bc310594e7b6e01fe74acb1b8e6d7e7410d4ddfdc047bfc25e44513fccecc9969c82f1fe8150effeabac0ee62ec563667b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6664eb2e046fcabbfc50b99c85ce1381625c113d386cdd91e14e6b66052b3eccea0c16ca6f082567f1ca4fea55f8fcb8f60b5103def042fce7740f54855cad39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 12:53:19.580945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:53:19.581407) ========= 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=f919189b672bc2eeae365d21000001d6-1453321926.652840-201966229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:53:19.664883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 12:53:19.665399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 12:53:19.665928) ========= ========= Total master_lag: 0.28 =========