builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1450403377.65 results: success (0) buildid: 20151217170333 builduid: 836ea215d41b4e0f870f6b5a353a94bb revision: 060a16fa37d75fb4badaa9fa1c7a48454531dedc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:37.653113) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:37.653560) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:37.653862) ========= 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=a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006426 basedir: '/builds/slave/test' ========= master_lag: 0.35 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.011167) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.011448) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.040189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.040483) ========= 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=a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.090620) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.090932) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.091365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.091645) ========= 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=a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 17:49:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.7M=0.001s 2015-12-17 17:49:38 (16.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.306410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.306755) ========= 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=a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013790 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:38.358032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 17:49:38.358418) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 060a16fa37d75fb4badaa9fa1c7a48454531dedc --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 060a16fa37d75fb4badaa9fa1c7a48454531dedc --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=a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 17:49:38,439 truncating revision to first 12 chars 2015-12-17 17:49:38,439 Setting DEBUG logging. 2015-12-17 17:49:38,439 attempt 1/10 2015-12-17 17:49:38,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/060a16fa37d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 17:49:39,223 unpacking tar archive at: fx-team-060a16fa37d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.059558 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 17:49:39.433311) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:39.433765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:39.445614) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:39.446093) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:49:39.446684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-17 17:49:39.447126) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:49:39 INFO - MultiFileLogger online at 20151217 17:49:39 in /builds/slave/test 17:49:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:49:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:49:39 INFO - {'append_to_log': False, 17:49:39 INFO - 'base_work_dir': '/builds/slave/test', 17:49:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:49:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:49:39 INFO - 'branch': 'Fx-Team-Non-PGO', 17:49:39 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:39 INFO - 'config_files': ('talos/linux_config.py',), 17:49:39 INFO - 'default_actions': ('clobber', 17:49:39 INFO - 'read-buildbot-config', 17:49:39 INFO - 'download-and-extract', 17:49:39 INFO - 'populate-webroot', 17:49:39 INFO - 'create-virtualenv', 17:49:39 INFO - 'install', 17:49:39 INFO - 'run-tests'), 17:49:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:39 INFO - 'download_minidump_stackwalk': True, 17:49:39 INFO - 'download_symbols': 'ondemand', 17:49:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:49:39 INFO - 'tooltool.py': '/tools/tooltool.py', 17:49:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:49:39 INFO - '/tools/misc-python/virtualenv.py')}, 17:49:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:39 INFO - 'installer_path': 'installer.exe', 17:49:39 INFO - 'log_level': 'info', 17:49:39 INFO - 'log_name': 'talos', 17:49:39 INFO - 'log_to_console': True, 17:49:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:49:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:49:39 INFO - 'opt_config_files': (), 17:49:39 INFO - 'pip_index': False, 17:49:39 INFO - 'sps_profile': False, 17:49:39 INFO - 'sps_profile_interval': 0, 17:49:39 INFO - 'suite': 'dromaeojs-e10s', 17:49:39 INFO - 'system_bits': '64', 17:49:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:39 INFO - 'title': 'talos-linux64-ix-031', 17:49:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:39 INFO - 'use_talos_json': True, 17:49:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:49:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:39 INFO - 'work_dir': 'build'} 17:49:39 INFO - ##### 17:49:39 INFO - ##### Running clobber step. 17:49:39 INFO - ##### 17:49:39 INFO - Running pre-action listener: _resource_record_pre_action 17:49:39 INFO - Running main action method: clobber 17:49:39 INFO - rmtree: /builds/slave/test/build 17:49:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:49:40 INFO - Running post-action listener: _resource_record_post_action 17:49:40 INFO - ##### 17:49:40 INFO - ##### Running read-buildbot-config step. 17:49:40 INFO - ##### 17:49:40 INFO - Running pre-action listener: _resource_record_pre_action 17:49:40 INFO - Running main action method: read_buildbot_config 17:49:40 INFO - Using buildbot properties: 17:49:40 INFO - { 17:49:40 INFO - "project": "", 17:49:40 INFO - "product": "firefox", 17:49:40 INFO - "script_repo_revision": "production", 17:49:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:49:40 INFO - "repository": "", 17:49:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:49:40 INFO - "buildid": "20151217170333", 17:49:40 INFO - "pgo_build": "False", 17:49:40 INFO - "basedir": "/builds/slave/test", 17:49:40 INFO - "buildnumber": 826, 17:49:40 INFO - "slavename": "talos-linux64-ix-031", 17:49:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:49:40 INFO - "platform": "ubuntu64_hw", 17:49:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:49:40 INFO - "branch": "fx-team", 17:49:40 INFO - "repo_path": "integration/fx-team", 17:49:40 INFO - "revision": "060a16fa37d75fb4badaa9fa1c7a48454531dedc", 17:49:40 INFO - "stage_platform": "linux64", 17:49:40 INFO - "builduid": "836ea215d41b4e0f870f6b5a353a94bb", 17:49:40 INFO - "slavebuilddir": "test" 17:49:40 INFO - } 17:49:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:49:40 INFO - Running post-action listener: _resource_record_post_action 17:49:40 INFO - ##### 17:49:40 INFO - ##### Running download-and-extract step. 17:49:40 INFO - ##### 17:49:40 INFO - Running pre-action listener: _resource_record_pre_action 17:49:40 INFO - Running main action method: download_and_extract 17:49:40 INFO - mkdir: /builds/slave/test/build/tests 17:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:40 INFO - https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/test_packages.json 17:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/test_packages.json 17:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:49:42 INFO - Downloaded 1302 bytes. 17:49:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:49:42 INFO - Using the following test package requirements: 17:49:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:49:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:49:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:42 INFO - u'jsshell-linux-x86_64.zip'], 17:49:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:49:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:49:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:49:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:49:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:49:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:49:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:49:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:49:42 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')]} 17:49:42 INFO - https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:49:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:49:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:49:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/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 17:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/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 17:49:43 INFO - Downloaded 21870957 bytes. 17:49:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:49:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:49:45 INFO - Return code: 0 17:49:45 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 17:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:45 INFO - https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:49:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:49:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:49:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/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 17:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/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 17:49:49 INFO - Downloaded 21870957 bytes. 17:49:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:49:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:49:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:49:50 INFO - Return code: 0 17:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:50 INFO - https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:49:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/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 17:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/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 17:49:51 INFO - Downloaded 11132039 bytes. 17:49:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 17:49:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:49:51 INFO - Return code: 0 17:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:51 INFO - https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:49:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:49:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:49:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/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 17:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1MQLhGc_SZSWHVSzv6lh6A/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 17:49:53 INFO - Downloaded 53022549 bytes. 17:49:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:49:53 INFO - mkdir: /builds/slave/test/properties 17:49:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:49:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:49:53 INFO - Contents: 17:49:53 INFO - build_url:https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:49:53 INFO - Running post-action listener: _resource_record_post_action 17:49:53 INFO - Running post-action listener: set_extra_try_arguments 17:49:53 INFO - ##### 17:49:53 INFO - ##### Running populate-webroot step. 17:49:53 INFO - ##### 17:49:53 INFO - Running pre-action listener: _resource_record_pre_action 17:49:53 INFO - Running main action method: populate_webroot 17:49:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:49:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:49:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:49:53 INFO - '--tppagecycles', 17:49:53 INFO - '7'], 17:49:53 INFO - 'tests': ['tsvgm']}}, 17:49:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:49:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:49:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:49:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:49:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:53 INFO - 'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:53 INFO - 'tests': ['damp', 'tps']}, 17:49:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:53 INFO - 'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['damp', 'tps']}, 17:49:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:49:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:49:53 INFO - 'other': {'tests': ['a11yr', 17:49:53 INFO - 'ts_paint', 17:49:53 INFO - 'tpaint', 17:49:53 INFO - 'sessionrestore', 17:49:53 INFO - 'sessionrestore_no_auto_restore']}, 17:49:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['a11yr', 17:49:53 INFO - 'ts_paint', 17:49:53 INFO - 'tpaint', 17:49:53 INFO - 'sessionrestore', 17:49:53 INFO - 'sessionrestore_no_auto_restore']}, 17:49:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['a11yr', 17:49:53 INFO - 'ts_paint', 17:49:53 INFO - 'tpaint', 17:49:53 INFO - 'sessionrestore', 17:49:53 INFO - 'sessionrestore_no_auto_restore']}, 17:49:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['a11yr', 17:49:53 INFO - 'ts_paint', 17:49:53 INFO - 'tpaint', 17:49:53 INFO - 'sessionrestore', 17:49:53 INFO - 'sessionrestore_no_auto_restore']}, 17:49:53 INFO - 'other_l64': {'tests': ['a11yr', 17:49:53 INFO - 'ts_paint', 17:49:53 INFO - 'tpaint', 17:49:53 INFO - 'sessionrestore', 17:49:53 INFO - 'sessionrestore_no_auto_restore']}, 17:49:53 INFO - 'other_nol64': {'tests': ['a11yr', 17:49:53 INFO - 'ts_paint', 17:49:53 INFO - 'tpaint', 17:49:53 INFO - 'sessionrestore', 17:49:53 INFO - 'sessionrestore_no_auto_restore']}, 17:49:53 INFO - 'svgr': {'tests': ['tsvgx', 17:49:53 INFO - 'tsvgr_opacity', 17:49:53 INFO - 'tart', 17:49:53 INFO - 'tscrollx', 17:49:53 INFO - 'cart']}, 17:49:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['tsvgx', 17:49:53 INFO - 'tsvgr_opacity', 17:49:53 INFO - 'tart', 17:49:53 INFO - 'tscrollx', 17:49:53 INFO - 'cart']}, 17:49:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:53 INFO - 'tests': ['tp5o']}, 17:49:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:53 INFO - 'talos_options': ['--e10s'], 17:49:53 INFO - 'tests': ['tp5o']}, 17:49:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:53 INFO - 'talos_options': ['--xperf_path', 17:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:53 INFO - 'tests': ['tp5n']}, 17:49:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:53 INFO - 'talos_options': ['--e10s', 17:49:53 INFO - '--xperf_path', 17:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:53 INFO - 'tests': ['tp5n']}}, 17:49:53 INFO - 'talos.zip': {'path': '', 17:49:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:49:53 INFO - Running post-action listener: _resource_record_post_action 17:49:53 INFO - ##### 17:49:53 INFO - ##### Running create-virtualenv step. 17:49:53 INFO - ##### 17:49:53 INFO - Running pre-action listener: _resource_record_pre_action 17:49:53 INFO - Running main action method: create_virtualenv 17:49:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:49:53 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 17:49:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:49:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:49:53 INFO - Using real prefix '/usr' 17:49:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:49:53 INFO - Installing distribute.............................................................................................................................................................................................done. 17:49:55 INFO - Installing pip.................done. 17:49:55 INFO - Return code: 0 17:49:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:49:55 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')]} 17:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:55 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')]} 17:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 17:49:55 INFO - Using env: {'DISPLAY': ':0', 17:49:55 INFO - 'HOME': '/home/cltbld', 17:49:55 INFO - 'LANG': 'en_US.UTF-8', 17:49:55 INFO - 'LANGUAGE': 'en_US:en', 17:49:55 INFO - 'LOGNAME': 'cltbld', 17:49:55 INFO - 'MAIL': '/var/mail/cltbld', 17:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:55 INFO - 'MOZ_NO_REMOTE': '1', 17:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:55 INFO - 'NO_EM_RESTART': '1', 17:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:55 INFO - 'PWD': '/builds/slave/test', 17:49:55 INFO - 'SHELL': '/bin/bash', 17:49:55 INFO - 'SHLVL': '1', 17:49:55 INFO - 'TERM': 'linux', 17:49:55 INFO - 'TMOUT': '86400', 17:49:55 INFO - 'USER': 'cltbld', 17:49:55 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:55 INFO - '_': '/tools/buildbot/bin/python'} 17:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:55 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 17:49:55 INFO - Cleaning up... 17:49:55 INFO - Return code: 0 17:49:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:49:55 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')]} 17:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:55 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')]} 17:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 17:49:55 INFO - Using env: {'DISPLAY': ':0', 17:49:55 INFO - 'HOME': '/home/cltbld', 17:49:55 INFO - 'LANG': 'en_US.UTF-8', 17:49:55 INFO - 'LANGUAGE': 'en_US:en', 17:49:55 INFO - 'LOGNAME': 'cltbld', 17:49:55 INFO - 'MAIL': '/var/mail/cltbld', 17:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:55 INFO - 'MOZ_NO_REMOTE': '1', 17:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:55 INFO - 'NO_EM_RESTART': '1', 17:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:55 INFO - 'PWD': '/builds/slave/test', 17:49:55 INFO - 'SHELL': '/bin/bash', 17:49:55 INFO - 'SHLVL': '1', 17:49:55 INFO - 'TERM': 'linux', 17:49:55 INFO - 'TMOUT': '86400', 17:49:55 INFO - 'USER': 'cltbld', 17:49:55 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:55 INFO - '_': '/tools/buildbot/bin/python'} 17:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:56 INFO - Downloading/unpacking psutil>=0.7.1 17:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:49:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:57 INFO - Installing collected packages: psutil 17:49:57 INFO - Running setup.py install for psutil 17:49:57 INFO - building 'psutil._psutil_linux' extension 17:49:57 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 17:49:58 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 17:49:58 INFO - building 'psutil._psutil_posix' extension 17:49:58 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 17:49:58 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 17:49:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:58 INFO - Successfully installed psutil 17:49:58 INFO - Cleaning up... 17:49:59 INFO - Return code: 0 17:49:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 17:49:59 INFO - Using env: {'DISPLAY': ':0', 17:49:59 INFO - 'HOME': '/home/cltbld', 17:49:59 INFO - 'LANG': 'en_US.UTF-8', 17:49:59 INFO - 'LANGUAGE': 'en_US:en', 17:49:59 INFO - 'LOGNAME': 'cltbld', 17:49:59 INFO - 'MAIL': '/var/mail/cltbld', 17:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:59 INFO - 'MOZ_NO_REMOTE': '1', 17:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:59 INFO - 'NO_EM_RESTART': '1', 17:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:59 INFO - 'PWD': '/builds/slave/test', 17:49:59 INFO - 'SHELL': '/bin/bash', 17:49:59 INFO - 'SHLVL': '1', 17:49:59 INFO - 'TERM': 'linux', 17:49:59 INFO - 'TMOUT': '86400', 17:49:59 INFO - 'USER': 'cltbld', 17:49:59 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:59 INFO - '_': '/tools/buildbot/bin/python'} 17:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:50:01 INFO - Installing collected packages: mozsystemmonitor 17:50:01 INFO - Running setup.py install for mozsystemmonitor 17:50:01 INFO - Successfully installed mozsystemmonitor 17:50:01 INFO - Cleaning up... 17:50:01 INFO - Return code: 0 17:50:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 17:50:01 INFO - Using env: {'DISPLAY': ':0', 17:50:01 INFO - 'HOME': '/home/cltbld', 17:50:01 INFO - 'LANG': 'en_US.UTF-8', 17:50:01 INFO - 'LANGUAGE': 'en_US:en', 17:50:01 INFO - 'LOGNAME': 'cltbld', 17:50:01 INFO - 'MAIL': '/var/mail/cltbld', 17:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:01 INFO - 'MOZ_NO_REMOTE': '1', 17:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:01 INFO - 'NO_EM_RESTART': '1', 17:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:01 INFO - 'PWD': '/builds/slave/test', 17:50:01 INFO - 'SHELL': '/bin/bash', 17:50:01 INFO - 'SHLVL': '1', 17:50:01 INFO - 'TERM': 'linux', 17:50:01 INFO - 'TMOUT': '86400', 17:50:01 INFO - 'USER': 'cltbld', 17:50:01 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:01 INFO - '_': '/tools/buildbot/bin/python'} 17:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:50:01 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 17:50:01 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 17:50:01 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 17:50:01 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 17:50:01 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 17:50:01 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 17:50:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:50:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:50:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:50:03 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 17:50:03 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 17:50:03 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 17:50:03 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 17:50:03 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 17:50:03 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 17:50:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:50:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:50:03 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 17:50:03 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 17:50:03 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 17:50:03 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 17:50:03 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 17:50:03 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 17:50:04 INFO - Downloading docopt-0.6.1.tar.gz 17:50:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:50:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:50:04 INFO - Running setup.py install for blobuploader 17:50:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:50:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:50:04 INFO - Running setup.py install for requests 17:50:04 INFO - Running setup.py install for docopt 17:50:04 INFO - Successfully installed blobuploader requests docopt 17:50:04 INFO - Cleaning up... 17:50:04 INFO - Return code: 0 17:50:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 17:50:04 INFO - Using env: {'DISPLAY': ':0', 17:50:04 INFO - 'HOME': '/home/cltbld', 17:50:04 INFO - 'LANG': 'en_US.UTF-8', 17:50:04 INFO - 'LANGUAGE': 'en_US:en', 17:50:04 INFO - 'LOGNAME': 'cltbld', 17:50:04 INFO - 'MAIL': '/var/mail/cltbld', 17:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:04 INFO - 'MOZ_NO_REMOTE': '1', 17:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:04 INFO - 'NO_EM_RESTART': '1', 17:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:04 INFO - 'PWD': '/builds/slave/test', 17:50:04 INFO - 'SHELL': '/bin/bash', 17:50:04 INFO - 'SHLVL': '1', 17:50:04 INFO - 'TERM': 'linux', 17:50:04 INFO - 'TMOUT': '86400', 17:50:04 INFO - 'USER': 'cltbld', 17:50:04 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:04 INFO - '_': '/tools/buildbot/bin/python'} 17:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:04 INFO - Running setup.py (path:/tmp/pip-Aptyur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:04 INFO - Running setup.py (path:/tmp/pip-LNzWT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:05 INFO - Running setup.py (path:/tmp/pip-L65Caa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:05 INFO - Running setup.py (path:/tmp/pip-IWWQQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:05 INFO - Running setup.py (path:/tmp/pip-Z2niS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:05 INFO - Running setup.py (path:/tmp/pip-RZsojs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:05 INFO - Running setup.py (path:/tmp/pip-aE0MyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:05 INFO - Running setup.py (path:/tmp/pip-jBIhvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:05 INFO - Running setup.py (path:/tmp/pip-5Bkh7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:05 INFO - Running setup.py (path:/tmp/pip-Z0m4VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:05 INFO - Running setup.py (path:/tmp/pip-yftWpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:05 INFO - Running setup.py (path:/tmp/pip-HDa6hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:05 INFO - Running setup.py (path:/tmp/pip-XwWnbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:05 INFO - Running setup.py (path:/tmp/pip-1efc3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:05 INFO - Running setup.py (path:/tmp/pip-Hn5a7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:05 INFO - Running setup.py (path:/tmp/pip-7vSfhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:06 INFO - Running setup.py (path:/tmp/pip-No5r7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:50:06 INFO - Running setup.py install for manifestparser 17:50:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Running setup.py install for mozcrash 17:50:06 INFO - Running setup.py install for mozdebug 17:50:06 INFO - Running setup.py install for mozdevice 17:50:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Running setup.py install for mozfile 17:50:06 INFO - Running setup.py install for mozhttpd 17:50:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Running setup.py install for mozinfo 17:50:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Running setup.py install for mozInstall 17:50:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:50:06 INFO - Running setup.py install for mozleak 17:50:07 INFO - Running setup.py install for mozlog 17:50:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:50:07 INFO - Running setup.py install for moznetwork 17:50:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:50:07 INFO - Running setup.py install for mozprocess 17:50:07 INFO - Running setup.py install for mozprofile 17:50:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:50:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:50:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:50:07 INFO - Running setup.py install for mozrunner 17:50:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:50:07 INFO - Running setup.py install for mozscreenshot 17:50:07 INFO - Running setup.py install for moztest 17:50:07 INFO - Running setup.py install for mozversion 17:50:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:50:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:50:07 INFO - Cleaning up... 17:50:07 INFO - Return code: 0 17:50:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:07 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')]} 17:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:07 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')]} 17:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 17:50:07 INFO - Using env: {'DISPLAY': ':0', 17:50:07 INFO - 'HOME': '/home/cltbld', 17:50:07 INFO - 'LANG': 'en_US.UTF-8', 17:50:07 INFO - 'LANGUAGE': 'en_US:en', 17:50:07 INFO - 'LOGNAME': 'cltbld', 17:50:07 INFO - 'MAIL': '/var/mail/cltbld', 17:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:07 INFO - 'MOZ_NO_REMOTE': '1', 17:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:07 INFO - 'NO_EM_RESTART': '1', 17:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:07 INFO - 'PWD': '/builds/slave/test', 17:50:07 INFO - 'SHELL': '/bin/bash', 17:50:07 INFO - 'SHLVL': '1', 17:50:07 INFO - 'TERM': 'linux', 17:50:07 INFO - 'TMOUT': '86400', 17:50:07 INFO - 'USER': 'cltbld', 17:50:07 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:07 INFO - '_': '/tools/buildbot/bin/python'} 17:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:08 INFO - Running setup.py (path:/tmp/pip-L_fU0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:08 INFO - Running setup.py (path:/tmp/pip-X2WpuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:08 INFO - Running setup.py (path:/tmp/pip-swtEXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:08 INFO - Running setup.py (path:/tmp/pip-W036WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:08 INFO - Running setup.py (path:/tmp/pip-LeAWsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:08 INFO - Running setup.py (path:/tmp/pip-Y1pOSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:08 INFO - Running setup.py (path:/tmp/pip-NR8KnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:08 INFO - Running setup.py (path:/tmp/pip-T7XX1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:08 INFO - Running setup.py (path:/tmp/pip-hEHcuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:08 INFO - Running setup.py (path:/tmp/pip-0EcZaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:08 INFO - Running setup.py (path:/tmp/pip-Ct6_dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:08 INFO - Running setup.py (path:/tmp/pip-9IF25S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:08 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)) 17:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:08 INFO - Running setup.py (path:/tmp/pip-1gXzFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 17:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:09 INFO - Running setup.py (path:/tmp/pip-qdVQrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:09 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)) 17:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:09 INFO - Running setup.py (path:/tmp/pip-Pvil4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:09 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)) 17:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:09 INFO - Running setup.py (path:/tmp/pip-cpGfXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:09 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)) 17:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:09 INFO - Running setup.py (path:/tmp/pip-UHUpNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:09 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)) 17:50:09 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)) 17:50:09 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)) 17:50:09 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)) 17:50:09 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:50:09 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:50:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:50:09 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 17:50:09 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 17:50:09 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 17:50:09 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 17:50:09 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 17:50:09 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 17:50:11 INFO - Downloading blessings-1.5.1.tar.gz 17:50:11 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 17:50:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:50:11 INFO - Installing collected packages: blessings 17:50:11 INFO - Running setup.py install for blessings 17:50:11 INFO - Successfully installed blessings 17:50:11 INFO - Cleaning up... 17:50:11 INFO - Return code: 0 17:50:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:11 INFO - Reading from file tmpfile_stdout 17:50:11 INFO - Current package versions: 17:50:11 INFO - argparse == 1.2.1 17:50:11 INFO - blessings == 1.5.1 17:50:11 INFO - blobuploader == 1.2.4 17:50:11 INFO - docopt == 0.6.1 17:50:11 INFO - manifestparser == 1.1 17:50:11 INFO - mozInstall == 1.12 17:50:11 INFO - mozcrash == 0.16 17:50:11 INFO - mozdebug == 0.1 17:50:11 INFO - mozdevice == 0.47 17:50:11 INFO - mozfile == 1.2 17:50:11 INFO - mozhttpd == 0.7 17:50:11 INFO - mozinfo == 0.9 17:50:11 INFO - mozleak == 0.1 17:50:11 INFO - mozlog == 3.1 17:50:11 INFO - moznetwork == 0.27 17:50:11 INFO - mozprocess == 0.22 17:50:11 INFO - mozprofile == 0.27 17:50:11 INFO - mozrunner == 6.11 17:50:11 INFO - mozscreenshot == 0.1 17:50:11 INFO - mozsystemmonitor == 0.0 17:50:11 INFO - moztest == 0.7 17:50:11 INFO - mozversion == 1.4 17:50:11 INFO - psutil == 3.1.1 17:50:11 INFO - requests == 1.2.3 17:50:11 INFO - wsgiref == 0.1.2 17:50:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:11 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')]} 17:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:11 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')]} 17:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 17:50:11 INFO - Using env: {'DISPLAY': ':0', 17:50:11 INFO - 'HOME': '/home/cltbld', 17:50:11 INFO - 'LANG': 'en_US.UTF-8', 17:50:11 INFO - 'LANGUAGE': 'en_US:en', 17:50:11 INFO - 'LOGNAME': 'cltbld', 17:50:11 INFO - 'MAIL': '/var/mail/cltbld', 17:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:11 INFO - 'MOZ_NO_REMOTE': '1', 17:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:11 INFO - 'NO_EM_RESTART': '1', 17:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:11 INFO - 'PWD': '/builds/slave/test', 17:50:11 INFO - 'SHELL': '/bin/bash', 17:50:11 INFO - 'SHLVL': '1', 17:50:11 INFO - 'TERM': 'linux', 17:50:11 INFO - 'TMOUT': '86400', 17:50:11 INFO - 'USER': 'cltbld', 17:50:11 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:11 INFO - '_': '/tools/buildbot/bin/python'} 17:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:11 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 1)) 17:50:11 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 2)) 17:50:11 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 3)) 17:50:11 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 4)) 17:50:11 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 5)) 17:50:11 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 6)) 17:50:11 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 7)) 17:50:11 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 8)) 17:50:11 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:50:11 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 3)) 17:50:11 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:50:11 INFO - Cleaning up... 17:50:11 INFO - Return code: 0 17:50:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:50:11 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')]} 17:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:11 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')]} 17:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 17:50:11 INFO - Using env: {'DISPLAY': ':0', 17:50:11 INFO - 'HOME': '/home/cltbld', 17:50:11 INFO - 'LANG': 'en_US.UTF-8', 17:50:11 INFO - 'LANGUAGE': 'en_US:en', 17:50:11 INFO - 'LOGNAME': 'cltbld', 17:50:11 INFO - 'MAIL': '/var/mail/cltbld', 17:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:11 INFO - 'MOZ_NO_REMOTE': '1', 17:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:11 INFO - 'NO_EM_RESTART': '1', 17:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:11 INFO - 'PWD': '/builds/slave/test', 17:50:11 INFO - 'SHELL': '/bin/bash', 17:50:11 INFO - 'SHLVL': '1', 17:50:11 INFO - 'TERM': 'linux', 17:50:11 INFO - 'TMOUT': '86400', 17:50:11 INFO - 'USER': 'cltbld', 17:50:11 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:11 INFO - '_': '/tools/buildbot/bin/python'} 17:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:11 INFO - Downloading/unpacking jsonschema 17:50:11 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 17:50:11 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 17:50:11 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 17:50:11 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 17:50:11 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 17:50:11 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 17:50:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:50:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 17:50:13 INFO - Downloading/unpacking functools32 (from jsonschema) 17:50:13 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 17:50:13 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 17:50:13 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 17:50:13 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 17:50:13 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 17:50:13 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 17:50:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:50:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:50:13 INFO - warning: no files found matching '*.txt' 17:50:13 INFO - no previously-included directories found matching 'build' 17:50:13 INFO - no previously-included directories found matching 'dist' 17:50:13 INFO - no previously-included directories found matching '.git*' 17:50:13 INFO - Installing collected packages: jsonschema, functools32 17:50:13 INFO - Running setup.py install for functools32 17:50:13 INFO - warning: no files found matching '*.txt' 17:50:13 INFO - no previously-included directories found matching 'build' 17:50:13 INFO - no previously-included directories found matching 'dist' 17:50:13 INFO - no previously-included directories found matching '.git*' 17:50:13 INFO - Successfully installed jsonschema functools32 17:50:13 INFO - Cleaning up... 17:50:14 INFO - Return code: 0 17:50:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f6ccfda2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, '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': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', '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 17:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 17:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 17:50:14 INFO - Using env: {'DISPLAY': ':0', 17:50:14 INFO - 'HOME': '/home/cltbld', 17:50:14 INFO - 'LANG': 'en_US.UTF-8', 17:50:14 INFO - 'LANGUAGE': 'en_US:en', 17:50:14 INFO - 'LOGNAME': 'cltbld', 17:50:14 INFO - 'MAIL': '/var/mail/cltbld', 17:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:14 INFO - 'MOZ_NO_REMOTE': '1', 17:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:14 INFO - 'NO_EM_RESTART': '1', 17:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:14 INFO - 'PWD': '/builds/slave/test', 17:50:14 INFO - 'SHELL': '/bin/bash', 17:50:14 INFO - 'SHLVL': '1', 17:50:14 INFO - 'TERM': 'linux', 17:50:14 INFO - 'TMOUT': '86400', 17:50:14 INFO - 'USER': 'cltbld', 17:50:14 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:14 INFO - '_': '/tools/buildbot/bin/python'} 17:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:14 INFO - Downloading/unpacking flake8 17:50:14 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 17:50:14 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 17:50:14 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 17:50:14 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 17:50:14 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 17:50:14 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 17:50:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:50:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 17:50:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:50:15 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 17:50:15 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 17:50:15 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 17:50:15 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 17:50:15 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 17:50:15 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 17:50:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:50:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 17:50:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:50:16 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 17:50:16 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 17:50:16 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 17:50:16 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 17:50:16 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 17:50:16 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 17:50:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 17:50:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:50:16 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 17:50:16 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 17:50:16 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 17:50:16 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 17:50:16 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 17:50:16 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 17:50:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:50:16 INFO - no previously-included directories found matching 'docs/_build' 17:50:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:50:16 INFO - Running setup.py install for pep8 17:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:50:16 INFO - no previously-included directories found matching 'docs/_build' 17:50:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:50:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:50:16 INFO - Cleaning up... 17:50:16 INFO - Return code: 0 17:50:16 INFO - Running post-action listener: _resource_record_post_action 17:50:16 INFO - Running post-action listener: _start_resource_monitoring 17:50:16 INFO - Starting resource monitoring. 17:50:16 INFO - ##### 17:50:16 INFO - ##### Running install step. 17:50:16 INFO - ##### 17:50:16 INFO - Running pre-action listener: _resource_record_pre_action 17:50:16 INFO - Running main action method: install 17:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:17 INFO - Reading from file tmpfile_stdout 17:50:17 INFO - Detecting whether we're running mozinstall >=1.0... 17:50:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:50:17 INFO - Reading from file tmpfile_stdout 17:50:17 INFO - Output received: 17:50:17 INFO - Usage: mozinstall [options] installer 17:50:17 INFO - Options: 17:50:17 INFO - -h, --help show this help message and exit 17:50:17 INFO - -d DEST, --destination=DEST 17:50:17 INFO - Directory to install application into. [default: 17:50:17 INFO - "/builds/slave/test"] 17:50:17 INFO - --app=APP Application being installed. [default: firefox] 17:50:17 INFO - mkdir: /builds/slave/test/build/application 17:50:17 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'] 17:50:17 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 17:50:32 INFO - Reading from file tmpfile_stdout 17:50:32 INFO - Output received: 17:50:32 INFO - /builds/slave/test/build/application/firefox/firefox 17:50:32 INFO - Running post-action listener: _resource_record_post_action 17:50:32 INFO - ##### 17:50:32 INFO - ##### Running run-tests step. 17:50:32 INFO - ##### 17:50:32 INFO - Running pre-action listener: _resource_record_pre_action 17:50:32 INFO - Running main action method: run_tests 17:50:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:50:32 INFO - Python 2.7.3 17:50:32 INFO - Return code: 0 17:50:32 INFO - grabbing minidump binary from tooltool 17:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:32 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 0x2cbd0b0>, '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 0x2cbdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:50:32 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 17:50:32 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 17:50:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:50:32 INFO - Return code: 0 17:50:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:50:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:50:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:50:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:50:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:50:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:50:33 INFO - Return code: 0 17:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] in /builds/slave/test/build 17:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost 17:50:33 INFO - Using env: {'DISPLAY': ':0', 17:50:33 INFO - 'HOME': '/home/cltbld', 17:50:33 INFO - 'LANG': 'en_US.UTF-8', 17:50:33 INFO - 'LANGUAGE': 'en_US:en', 17:50:33 INFO - 'LOGNAME': 'cltbld', 17:50:33 INFO - 'MAIL': '/var/mail/cltbld', 17:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:33 INFO - 'MOZ_NO_REMOTE': '1', 17:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:33 INFO - 'NO_EM_RESTART': '1', 17:50:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:33 INFO - 'PWD': '/builds/slave/test', 17:50:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:50:33 INFO - 'SHELL': '/bin/bash', 17:50:33 INFO - 'SHLVL': '1', 17:50:33 INFO - 'TERM': 'linux', 17:50:33 INFO - 'TMOUT': '86400', 17:50:33 INFO - 'USER': 'cltbld', 17:50:33 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828', 17:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:33 INFO - '_': '/tools/buildbot/bin/python'} 17:50:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] with output_timeout 3600 17:50:33 INFO - mozversion INFO | application_buildid: 20151217170333 17:50:33 INFO - mozversion INFO | application_changeset: 060a16fa37d75fb4badaa9fa1c7a48454531dedc 17:50:33 INFO - mozversion INFO | application_display_name: Nightly 17:50:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:50:33 INFO - mozversion INFO | application_name: Firefox 17:50:33 INFO - mozversion INFO | application_remotingname: firefox 17:50:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:50:33 INFO - mozversion INFO | application_vendor: Mozilla 17:50:33 INFO - mozversion INFO | application_version: 46.0a1 17:50:33 INFO - mozversion INFO | platform_buildid: 20151217170333 17:50:33 INFO - mozversion INFO | platform_changeset: 060a16fa37d75fb4badaa9fa1c7a48454531dedc 17:50:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:50:33 INFO - mozversion INFO | platform_version: 46.0a1 17:50:33 INFO - 2015-12-17 17:50:33,734 DEBUG : using testdate: 1450403433 17:50:33 INFO - 2015-12-17 17:50:33,734 DEBUG : actual date: 1450403433 17:50:33 INFO - 2015-12-17 17:50:33,809 INFO : starting webserver on 'localhost:56503' 17:50:33 INFO - 2015-12-17 17:50:33,810 INFO : Starting test suite talos-linux64-ix-031.e 17:50:33 INFO - 2015-12-17 17:50:33,811 INFO : Starting test dromaeo_css 17:50:33 INFO - 2015-12-17 17:50:33,811 DEBUG : operating with platform_type : linux_ 17:50:33 INFO - 2015-12-17 17:50:33,811 INFO : Initialising browser for dromaeo_css test... 17:50:33 INFO - 2015-12-17 17:50:33,826 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi9b0ve/profile http://localhost:56503/getInfo.html 17:50:38 INFO - 2015-12-17 17:50:38,614 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:50:38 INFO - 2015-12-17 17:50:38,614 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:50:38 INFO - 2015-12-17 17:50:38,614 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:50:38 INFO - 2015-12-17 17:50:38,614 DEBUG : BROWSER_OUTPUT: __metrics 17:50:38 INFO - 2015-12-17 17:50:38,759 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:50:39 INFO - 2015-12-17 17:50:39,656 INFO : Browser initialized. 17:50:39 INFO - 2015-12-17 17:50:39,657 INFO : Running cycle 1/1 for dromaeo_css test... 17:50:39 INFO - 2015-12-17 17:50:39,657 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi9b0ve/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:50:51 INFO - 2015-12-17 17:50:51,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 150736896 17:50:51 INFO - 2015-12-17 17:50:51,616 DEBUG : BROWSER_OUTPUT: 17:51:41 INFO - 2015-12-17 17:51:41,271 DEBUG : BROWSER_OUTPUT: 1450403501270 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] 17:53:53 INFO - 2015-12-17 17:53:53,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56503/tests/dromaeo/cssquery-ext.html) 17:53:54 INFO - 2015-12-17 17:53:54,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 154255360 17:53:54 INFO - 2015-12-17 17:53:54,485 DEBUG : BROWSER_OUTPUT: 17:56:56 INFO - 2015-12-17 17:56:56,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/dromaeo/cssquery-ext.html (next: http://localhost:56503/tests/dromaeo/cssquery-jquery.html) 17:56:57 INFO - 2015-12-17 17:56:57,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 153223168 17:56:57 INFO - 2015-12-17 17:56:57,049 DEBUG : BROWSER_OUTPUT: 17:59:58 INFO - 2015-12-17 17:59:58,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56503/tests/dromaeo/cssquery-mootools.html) 17:59:59 INFO - 2015-12-17 17:59:59,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 154615808 17:59:59 INFO - 2015-12-17 17:59:59,399 DEBUG : BROWSER_OUTPUT: 18:03:01 INFO - 2015-12-17 18:03:01,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56503/tests/dromaeo/cssquery-prototype.html) 18:03:01 INFO - 2015-12-17 18:03:01,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 151117824 18:03:01 INFO - 2015-12-17 18:03:01,783 DEBUG : BROWSER_OUTPUT: 18:06:04 INFO - 2015-12-17 18:06:04,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56503/tests/dromaeo/cssquery-yui.html) 18:06:04 INFO - 2015-12-17 18:06:04,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 152739840 18:06:04 INFO - 2015-12-17 18:06:04,995 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/dromaeo/cssquery-yui.html (next: http://localhost:56503/tests/dromaeo/cssquery-dojo.html) 18:09:07 INFO - 2015-12-17 18:09:07,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 155516928 18:09:07 INFO - 2015-12-17 18:09:07,554 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,555 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:09:07 INFO - 2015-12-17 18:09:07,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:09:07 INFO - 2015-12-17 18:09:07,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:09:07 INFO - 2015-12-17 18:09:07,556 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:09:07 INFO - 2015-12-17 18:09:07,559 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2679.022156912727;2717.904873329434;2756.779457643389;2767.1975127213104;2767.501849667059;4635.907281854369;4750.643701722367;4774.498677638846;4813.2780082987565;4848.127337079329;4702.24764037754;4709.963807962243;4721.575058244757;4855.2959820826045;4855.5872750816225;4367.519572846984;4473.753943533105;4546.227141385956;4551.385562949009;4578.5650363215445;4435.201663700533;4480.52954439784;4508.752018638974;4531.932021019671;4594.931076033846;4218.303979843353;4321.330193819963;4490.079533695584;4512.729236245836;4567.931481027787;4317.15815415994;4415.735055896656;4423.955760442419;4436.55634436557;4440.422745043156;4359.302511598129;4398.186335527937;4432.955670443286;4441.467023957146;4483.820647174109;4485.618722408566;4631.444226692818;4646.79089440976;4686.2267725825195;4701;5094.490550944913;5135.255387968761;5144.254083157921;5148.819791307324;5158.2520534522655;5152.871178220537;5178.974105129488;5181.533661970403;5189.299444574972;5216.504432078947;4655.998960223535;4743.075100355398;4784.234522476457;4784.545468180518;4798.856034318976;5188.403333616607;5219.869503262449;5239.711815850165;5249;5314.335708036496;5045.091883461012;5047.520485553867;5047.621428392885;5054.039732450822;5088.414832294259;4945.455999840015;5063.670861393997;5066.06277838601;5125.8718532037;5206.76569554371;5129.102407078821;5139.691618502902;5140.177571588602;5161.2516185152945;5176.171812510056;5100.413452452941;5107.846764597068;5112.437631860493;5129.281900533928;5175.353080864892;4108.979455102765;4144.5233798113;4224.4930608327195;4243.533211346749;4254.127903779779;3692.7968961707365;3693.649103335179;3702.5927148013698;3734.6638802507905;3741.6819570336284;4236.872893813191;4427.070315233773;4434.445694288214;4442.844500442469;4462.308342206963;5095.668781529189;5123.180291153398;5149.588032957355;5156.04613146569;5220.034293655686;4455.108978204307;4461.665375096881;4475.1049790042125;4478.462584489882;4501.7974191161475;4355.934660980088;4573.5426457354;4594.425696787902;4608.769561521911;4627.6529260305615;4766;4801.5438533339275;4888.682235654671;4904.975475122745;4947.060058588857;5169.147090729987;5176.741162941763;5180.430152683127;5199.7140157291715;5205.687658740488;4694.7887345068875;4826.444958829779;4894.461609222912;4899.31409602663;4925.975370123269;4983.127952608352;5068.239764035424;5077.593792496666;5086.338775959101;5137.409197942285;5114.820981265638;5126.179811230334;5129.563987061141;5130.846074617767;5148.30497882796;4831.154547954024;4889.242167463906;4936.062148191976;4980.327655766425;4980.377452818398;4992.80028798844;5000.574951129195;5020.774065167003;5024.171011783161;5027.4218464877;4869.975650121868;4916.803327866988;4944.381952255968;4951.1088004158155;4973.6269779765935;4851.345068415719;4871.561559459666;4971.328870602422;5015.623828212972;5089.491050895029;4924.704517728947;4939.580135688507;4942.752862356796;4953.133201689762;5007.37407824022 18:09:07 INFO - 2015-12-17 18:09:07,561 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.7582777319641;569.4874612848436;585.5023230254285;587.6885250817065;588.3763210996347;34861.3027739445;35171.824140879326;35299.82350088246;35314.11714707134;35473.113172170706;39834.601653983525;40043;40381.59618403815;40440.191196176056;40556.188876222455;7753.651085701143;7937.761867143995;7942.523448593074;7949.046114466272;7961.681532738684;7879.487833290817;7978.760637180894;7988.320992715626;7989.161138080505;7991.840163196733;7942.205779422041;8021.919780802175;8026.117127116013;8032.3574114071025;8042.235987581171;7961.641726122339;8016.959915200445;8034.678612855479;8066.637001334954;8094.676212951475;7890.80272993174;7953.244441778022;8013.67945282188;8024.398170137263;8025.95987020067;36494;36750.081247969014;36907.81546092279;36917.446238306446;36944.26111477782;2802.8178168418985;2839.2334069801245;2999.505081661523;3483.372992861284;3597.5862775780856;27181.45637087267;27509.587356189473;27787.444251115066;28055.43889122206;28281.15156545307;3378.679025492574;3418.1454636340914;3418.6581341865863;3513.8067406292644;3516.4022116240044;220466;221823.9999999984;222146;222405;222470;50568.49431505638;50598.494015059376;53031.73484132632;53795.193072103946;53844;47044;47179.5282047182;47184.29223561649;47277.527224728;47290.76354618205;12831.550895718605;12897;13060.542880999119;13079.869201308056;13152.079354445097;10350.378977261389;10520.316179448464;10538.473076346305;10544.683659490227;10563.735906602396;17395.130243487776;17762.91118544399;18539.07304634763;18573.47104050226;18610;7501;7690.46166768332;7824.882626760603;7875.763727088197;7896.368290536858;791.4855344026314;920.346553946692;1017.211660962745;1057.8254587992894;1062.573789846509;25761.355966100997;25861.612075818877;25973.740262597512;26127.738722612532;26145.86249650016;933.355984370782;1009.7425156585024;1045.383223897904;1065.2702898514387;1066.9253152279266;13757.724845503235;13829.446822127204;13869.583912482642;13893.722125557431;14443.566692999228;268368;269914;270538;270794;270818;44591;44789.77605111954;44971.32543011857;45058.77470612692;45119.32321015187;1251.217988757027;1263.5198624522623;1263.5261776833688;1265.6645988812788;1275.9681007974689;26101;26364.868175658998;26468;26670.59994100129;26994;38706;38844.41733374058;39101.6089839098;39169;39169.41245881371;253205;253413;253758;253784;256324;27603.171904842886;30558.541621875243;31016.689833102282;31029.224269392544;31217.375652486367;36159.27681446409;36313.55021272975;36837.44743828791;37194.256114878095;37388.439173411876;31113.688863111078;31411.214719632193;31500;32198.678013219567;32365.838170808995;31330.530042048933;31653.84173079212;31787.68212317847;32098;32205.35589288248;31459.37081258316;31825.363492730477;31866.840665796524;31880.36239275155;32122.19694507656;26550.336241594116;28750;30799.497240286142;32632.34735305328;32802.17994550155;22104.66842997324;22186.77813221847;22243.22148724787;22313.553728925654;22444 18:09:07 INFO - 2015-12-17 18:09:07,564 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.2428928452064;324.8700519792083;327.4727688421641;328.0045063233087;334.74726581431014;14814.407423703053;15261;16133.515994520169;16152.676946461093;16703.415380461687;15368.538943831674;15410.845891541081;15592.766108508353;15703.764443533357;15704.764428533552;4509.0530988492455;4648.372469716579;4649.39557857478;4650.906981860361;4657.32468792025;4516.277395616702;4582.679212455129;4585.3122031695175;4587.885302867422;4592.586667199951;4583.152116858375;4720.952790472085;4904.509549045085;5031.899362012758;5063.367079115111;4978.253262010691;4984.975075124601;4995.475475075137;5004.074246264435;5014.423341315741;4947.505249475023;4960.727160006199;5002.874928126789;5012.874678133039;5016.924746128811;11339.943300283529;11435.313881167156;13307;18609.62780744391;18634;1817.1380076379755;1845.280340667141;1856.5173055005662;1881.7930027696943;1996.5208349996042;8782.429142105742;9016.954915225382;11568.652940411801;12686.302253376061;12903.419346129447;1631.5350125214256;1742.442418426104;1749.448923589078;1763.2141216877303;1817.0642119308566;55386.892262154935;55597.444025560035;56117.158242625985;56816.715916420566;56905.14642280369;9507.477088760184;9660.420374777535;9687.757806054906;9689.370190937707;9736.318457707892;12409.75180496385;12456.564020259248;12465.501379944883;12475.812862807064;12490.12569120171;6747.865042699119;6865.27914568973;6899.6205208713;7026.051483049825;7121.074260346122;6450.8064758057335;6451;6469.223693156757;6538.934610653928;6539.738410463623;4084.9795751021056;4094.8566800161852;4096.549379568245;4113.4446849675505;4165.250254954077;1725.5168552805235;1751.20320254284;1759.0676941221172;1761.6652835961127;1783.8662100342526;789.8578255913991;926.6339795780764;931.1247427418206;964.4165280005636;1014.102519270451;14475.565733028026;14571.271436428136;14881.33034013472;15086.321115549827;16318.918405407898;835.6796261906173;878.3412440669498;884.752269364579;890.9198172164537;916.1845957098188;9092.454452732858;9094.317926155565;9108.18026377616;9194.586243619053;9294.535273236312;410608;414320;426912;426959;427858;69830.65084674544;70825.2917470829;71803.64098179476;71971;72704.63647681728;1059.3167407022581;1060.7666313411037;1069.4813015687384;1082.155918383662;1085.92398532102;13673.453061877413;14258.643533911736;14396.20820854863;14505.347259373142;14542.200178990257;32558.34883302368;32924.67075329216;33311.333773324885;34149.48775768415;35809.46285805663;41154.79422602868;41197.79401102975;42011.36982945319;42504.3256261564;43803.34294985514;8889.111088891059;9097.317701172571;9162.496062716615;9165.725028249164;9182.219511341611;10611.787764244826;12366.505339786667;16901;16943.491695249162;16958.57603559921;13776.65558361049;14073.577792666236;14230.359633816295;14252.928735356258;14295.857041429868;13494.66263343385;13823.654408639864;13968.441262349392;14100.08349457282;14210.786838197642;14179.64550886236;14385.28073596337;14513.419463221353;14590.051646642934;14723.705525889636;8996.055414181417;9151;9162.862557061782;9175.311851611023;9175.678851240174;13385.397657105259;13410.664733381744;13607.251601162032;13650.249236292098;13992.930035350166 18:09:07 INFO - 2015-12-17 18:09:07,565 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1491.7314883320998;1636.2636813433955;1667.7998640163182;1688.9577760555992;1704.6420251747134;6981.860362792748;6983.860322793554;7061;7185.46109041822;7213.206547279795;7155.7137714491355;7159.427245820335;7224.458165637585;7226.855462890739;7271.90921361796;2030.2285131649953;2078.158345869925;2086.6765651324067;2091.027672132458;2092.3827470896044;2055.1162999910034;2074.6680531115026;2079.5217100066993;2095;2099.2757498663013;1990.661587530116;2010.728551645531;2035.989820050905;2036.0328843799225;2045.233037610896;2036.0735865181382;2041.397787652646;2059.3101311060814;2062.185436752482;2065.917363305466;1985.4043786863883;2024.898755062241;2034.8575599708026;2035.1147250945885;2037.3378651938178;7034.859302813967;7211.819704507377;7213.386862116727;7215.350618444365;7219.783406497813;3955.8417663293435;3995.141044675409;4018.4374187613757;4030;4053.108316170438;2656.3890305229907;2670.0788228061288;2718.660167479065;2727.154582079562;2732.9180124596296;819.6844214977276;820.9425340226187;871.2289623683023;889.226373055446;893.7050773244814;9422.717318480456;9471.952640236823;9472.479013654178;9478.715638530855;9493.810123797555;3589.5513060867393;3649.978006158227;3664.523611930432;3669.046048027532;3700.685441737429;7814.921850781419;7838.725644602411;7843.882341764878;7852.411069169835;7878.606069696492;4044.4742183515955;4057.5130984282073;4062.756234625932;4069.593040695907;4079.796010199478;3728.217074414349;3749.868754593631;3754.8498060077836;3769.98210483168;3778.7165962552917;3063.754899608026;3087.706667866549;3093.1648454917495;3117.610298712661;3135.0908236611585;883.3772190605607;892.6697122064877;927.4759760735163;930.8464103422995;930.948797816113;903.1375036839802;903.8689390038408;921.7050543825911;973.8344481438172;1216.7140721930339;6550.934490655128;6611.933880661132;6632.535722499475;6633.4693224541925;6672.899906501407;937.2876613773445;1014.0974532665933;1033.9017793309624;1043.446973104256;1057.1965306367217;5087.923681144785;5103.10695628271;5138.460461651547;5145.974270128625;5151.4333423323405;7981.640826162837;8425.578721063923;8425.747227583182;8435.11431299717;8462.746117616482;8259.42184047123;8261.297789687824;8334.583270836434;8378.958105209435;8383.413161078666;6437.806865794034;6517.641529715911;6527.738890444329;6552.770653027121;6579.80260592183;6237.750489980532;6259.280182778856;6298.275698294571;6320.4311611955145;6333.556651034383;7302.96348518254;7419.629018549159;7440.330370266702;7518.661660225193;7532.698692052257;7459.515131516434;7637.427192960661;7641.617919104134;7671.923280767121;7678.1170165431695;5846.269216347957;5875;5891.852703682271;5899.528037757055;5901.881962360814;6696.4977626679165;6956.513044086865;6996.230414654486;7001.474889383215;7007.544509606859;5805.477507024219;6456.870862582628;6498.642574658439;6608.306127856506;6723.361280678328;5569.359523654832;6490.967545162244;6527.477801775752;6623;6631.270560238467;6200.131981522501;6230.6884655766125;6231.345708700703;6240;6258.155149054819;6107.786227482017;6130.264368275835;6138.140660307471;6141.570090093651;6153.507719382528;5975.790847320323;5989.8203053908455;5998.430149135826;6008.279006519246;6018.759249629966 18:09:07 INFO - 2015-12-17 18:09:07,567 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.5566561488996;305.4562878077022;306.49734435525727;309.2624091541673;310.051243195821;5552;5582.27430434043;5598.936202121594;5669.773209071637;5765.5099316558035;5554.750036248369;5594.748236329365;5604.467575580314;5605.635633683808;5634.633748806325;4269.594388533084;4301.548337424572;4306.310990241562;4308.547602501739;4317.848875289365;4304.880731009945;4316.352547117926;4326.675499337546;4329.069250111225;4332;4112.424260603518;4196.664266858659;4219.198352313051;4270.871873843789;4278.978605106986;4202.390653355277;4220.366944958281;4224.767637779921;4231.259529582311;4244.469441319835;3664.486971823947;3670.5778835434;3676.5955744868043;3681.6134305897763;3687.4468829675493;5374.247605335257;5390.1914712793005;5403.2705584745945;5415.48552887475;5416.9729151353995;4670.789814458358;4762.357081793948;4875.561199492063;4880.097182021337;4892.315075889378;5854.912176317359;5856.912146317809;5860.179574859523;5867.093194711736;5871.060630299132;4013.518377794683;4017.7388469749667;4024.6981476389096;4025.4766880305665;4029.8589549365925;6079.787207447763;6129.356417576179;6180.474659653934;6180.721867515973;6182.598131121463;3969.364901615728;4052.63526282636;4063.227986682521;4140.523839758406;4141.81361838718;4097.545371393172;4109.8972525686495;4114.423980642712;4124.608162224584;4131.5042194936195;4771.284307353855;4812.989272252796;4820.156472617278;4824.831130910401;4826.396700412449;5834;5835.883282334329;5839.211706419664;5876.382979787061;5880.647161170344;1443.4370595467776;1465.8167729033871;1469.6472846516758;1470.529430582225;1474.9262536873327;961.0869673809908;985.4727720669407;997.3218211616171;998.1814911772277;1003.5985605757755;5099.4390617032095;5102.311187989648;5108.412532558729;5111.131107711698;5114.462981386975;6058.969705151534;6067.393260673985;6094.2077529920825;6103.084537319438;6103.755849766048;5060.114479965991;5083;5093.770780314895;5106.234064890296;5109.616778741609;3223.5325877747596;3279.967200327966;3283.1627934876456;3298.2578919742864;3299.6040475143136;5725.227094342294;5725.971370143123;5733.455321744427;5737.655740655574;5739.942600573941;6226.221722284715;6227.221597300338;6229.844253893689;6235.345288744707;6240.282367527792;5551.583631227593;5618.6628802272;5690.089585666274;5697.173909783141;5745;6123.755049797958;6156.199694039746;6158.692065396802;6167.660778657217;6174.073888916699;5987.31145918225;5989.7304621293015;5997.0404735242155;6004.759809607742;6008.699565021819;5629.718514074198;5758.424157584208;5768.711564421678;5780.913286300793;5781.971090144522;4167.97916010418;4171.916561668689;4179.080602267496;4183.581641835792;4185.497740271187;6124.846878828065;6134.631922084689;6135.723892424762;6138.07928810682;6143.017117261216;5891;5891.026506120497;5892.351841297368;5897.7935772247765;5902.350741418526;5748.597598168088;5894.557908156819;5896.321922978912;5902.793402230901;5915.526757859275;5757.165211044459;5767.9134812977;5772.5959182856795;5784.797532086357;5788.27646544182;5906.675132867734;5923.4076592340425;5937.317208521075;5941.405859414024;5950.7917222896995;5656.773729050792;5766.481016708516;5778.595498315246;5788.971055144697;5796.768129274782 18:09:07 INFO - 2015-12-17 18:09:07,568 DEBUG : BROWSER_OUTPUT: |5;yui.html;706.1428443194397;715.4526787007939;715.742332760206;726.4442701333479;753.2467532467532;11339.659810205696;11644.708882277948;11675.949164575186;11680.47437865296;11694.941525292372;9446.385984910994;10569.894301056987;10944.288621239613;10984.505697243623;11007.834882476749;779.2402407652522;793.4406243598278;794.7218473534246;795.4074214710021;796.5658715999793;772.2432016623712;776.7863837444692;781.0666253826679;784.2667106255641;784.2980532423478;821.6959724901794;824.5794644731201;828.2421584250403;829.4691397505601;829.6515463505342;817.5340056167987;817.8159914019358;818.0183779464636;818.5907046476761;818.8812622169781;606.4026933470528;607.74474720617;609.2932198649589;610.4109534299422;611.4435863364317;9780.217582593446;9794.90205097947;9863.950680246553;9865.260105492116;9877.506124693808;8870.689525866628;9275.58259878307;9598.520073996342;9608.231341492663;9728.951355243178;8221.383396245306;8340;8347.373946953941;8369.665213391458;8395.580220988926;3076.661567227603;3176.1583180457196;3185.729213016896;3185.7769956103084;3193.6327322357993;36879.81560092182;37352.813235933645;37461.438078428844;37555.43666844972;39013;8417.915820841836;8463.619137138843;8591.398602097917;8707.869381959275;8736.301095912311;15026.924865375822;15063.472778452702;15086.773698394532;15089.698206035819;15141.924290378478;6063.242094738158;6168.167297414881;6256.4056414641445;6326.114343991845;6352.809415717536;3529.7529172957647;3541.15012397028;3559.359315323215;3566.892993210208;3617.0595645132457;2443.902243910259;2478.5042991401792;2479.615659572769;2483.1184929350184;2484.0808900706493;450.9639228861683;452.5203284518421;455.51942700451343;455.68102328370276;461.39096392761235;430.6576271863876;486.2536007228887;550;555.4390066033254;558.2073455692926;6673.1992160941;6890.276520965327;7014.123234595676;7115.324044215791;7207.531510451909;545.4817922973191;551.5008916930185;555.919391688203;557.9868708971586;558.5196730811499;3306.173456635841;3321.308928244511;3384.933745870043;3386.5428167197115;3431;47675.52324476711;47723.52276477191;48207.27689084667;48237.517624824;48303;42546.36180457295;42550;43061.13877722491;43614.34578481325;43691.56308436939;38644.6135538641;39211.80394098011;39849.99999999942;39980.600193997685;40494;7152.749653762094;7222.277772222946;7476.925230747623;7534.133574638987;7699.6535155917;30604;30689.232769180056;31291.84354078215;31697.8415107923;31750.206244844063;36172.09569760777;36430;36838;39373.21253574855;39727.80136099301;9432.669856554987;9594.66418675343;10001.849972250568;10021.599136034478;10057.29598928068;10185.134263587383;10202.234832387452;10630.30902991303;10680.732981675521;10815.35107893529;9379.155875971195;9671.951640241754;9781.902180978099;9808.362456440309;10224.53989570486;9815.2147828175;9948.651797187353;10076.445795481319;10187.7453063674;10193.74515637115;9596.9040309596;9896.158826499828;9967;9983.400995940267;10133.391996480235;7856.607169641381;7964.163762805054;8058.194180581895;8086.676532938616;8099.230573095547;7983.960080199562;8343.41596088268;8368;8449.366297527587;8481.745547633582 18:09:07 INFO - 2015-12-17 18:09:07,568 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:09:07 INFO - 2015-12-17 18:09:07,568 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:09:07 INFO - 2015-12-17 18:09:07,568 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,327 18:09:07 INFO - 2015-12-17 18:09:07,568 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:09:07 INFO - 2015-12-17 18:09:07,569 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404547554__endTimestamp 18:09:07 INFO - 2015-12-17 18:09:07,569 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,569 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:09:07 INFO - 2015-12-17 18:09:07,569 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:09:07 INFO - 2015-12-17 18:09:07,569 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,569 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4735.07 Median:4871.56 stddev:498.75 (10.2%) stddev-sans-first:473.48 18:09:07 INFO - 2015-12-17 18:09:07,570 DEBUG : BROWSER_OUTPUT: Values: 2679.0 2717.9 2756.8 2767.2 2767.5 4635.9 4750.6 4774.5 4813.3 4848.1 4702.2 4710.0 4721.6 4855.3 4855.6 4367.5 4473.8 4546.2 4551.4 4578.6 4435.2 4480.5 4508.8 4531.9 4594.9 4218.3 4321.3 4490.1 4512.7 4567.9 4317.2 4415.7 4424.0 4436.6 4440.4 4359.3 4398.2 4433.0 4441.5 4483.8 4485.6 4631.4 4646.8 4686.2 4701.0 5094.5 5135.3 5144.3 5148.8 5158.3 5152.9 5179.0 5181.5 5189.3 5216.5 4656.0 4743.1 4784.2 4784.5 4798.9 5188.4 5219.9 5239.7 5249.0 5314.3 5045.1 5047.5 5047.6 5054.0 5088.4 4945.5 5063.7 5066.1 5125.9 5206.8 5129.1 5139.7 5140.2 5161.3 5176.2 5100.4 5107.8 5112.4 5129.3 5175.4 4109.0 4144.5 4224.5 4243.5 4254.1 3692.8 3693.6 3702.6 3734.7 3741.7 4236.9 4427.1 4434.4 4442.8 4462.3 5095.7 5123.2 5149.6 5156.0 5220.0 4455.1 4461.7 4475.1 4478.5 4501.8 4355.9 4573.5 4594.4 4608.8 4627.7 4766.0 4801.5 4888.7 4905.0 4947.1 5169.1 5176.7 5180.4 5199.7 5205.7 4694.8 4826.4 4894.5 4899.3 4926.0 4983.1 5068.2 5077.6 5086.3 5137.4 5114.8 5126.2 5129.6 5130.8 5148.3 4831.2 4889.2 4936.1 4980.3 4980.4 4992.8 5000.6 5020.8 5024.2 5027.4 4870.0 4916.8 4944.4 4951.1 4973.6 4851.3 4871.6 4971.3 5015.6 5089.5 4924.7 4939.6 4942.8 4953.1 5007.4 18:09:07 INFO - 2015-12-17 18:09:07,571 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,571 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40299.32 Median:32202.02 stddev:64962.14 (201.7%) stddev-sans-first:65075.88 18:09:07 INFO - 2015-12-17 18:09:07,571 DEBUG : BROWSER_OUTPUT: Values: 568.8 569.5 585.5 587.7 588.4 34861.3 35171.8 35299.8 35314.1 35473.1 39834.6 40043.0 40381.6 40440.2 40556.2 7753.7 7937.8 7942.5 7949.0 7961.7 7879.5 7978.8 7988.3 7989.2 7991.8 7942.2 8021.9 8026.1 8032.4 8042.2 7961.6 8017.0 8034.7 8066.6 8094.7 7890.8 7953.2 8013.7 8024.4 8026.0 36494.0 36750.1 36907.8 36917.4 36944.3 2802.8 2839.2 2999.5 3483.4 3597.6 27181.5 27509.6 27787.4 28055.4 28281.2 3378.7 3418.1 3418.7 3513.8 3516.4 220466.0 221824.0 222146.0 222405.0 222470.0 50568.5 50598.5 53031.7 53795.2 53844.0 47044.0 47179.5 47184.3 47277.5 47290.8 12831.6 12897.0 13060.5 13079.9 13152.1 10350.4 10520.3 10538.5 10544.7 10563.7 17395.1 17762.9 18539.1 18573.5 18610.0 7501.0 7690.5 7824.9 7875.8 7896.4 791.5 920.3 1017.2 1057.8 1062.6 25761.4 25861.6 25973.7 26127.7 26145.9 933.4 1009.7 1045.4 1065.3 1066.9 13757.7 13829.4 13869.6 13893.7 14443.6 268368.0 269914.0 270538.0 270794.0 270818.0 44591.0 44789.8 44971.3 45058.8 45119.3 1251.2 1263.5 1263.5 1265.7 1276.0 26101.0 26364.9 26468.0 26670.6 26994.0 38706.0 38844.4 39101.6 39169.0 39169.4 253205.0 253413.0 253758.0 253784.0 256324.0 27603.2 30558.5 31016.7 31029.2 31217.4 36159.3 36313.6 36837.4 37194.3 37388.4 31113.7 31411.2 31500.0 32198.7 32365.8 31330.5 31653.8 31787.7 32098.0 32205.4 31459.4 31825.4 31866.8 31880.4 32122.2 26550.3 28750.0 30799.5 32632.3 32802.2 22104.7 22186.8 22243.2 22313.6 22444.0 18:09:07 INFO - 2015-12-17 18:09:07,571 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,571 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24492.36 Median:4095.70 stddev:68945.40 (1683.4%) stddev-sans-first:69114.93 18:09:07 INFO - 2015-12-17 18:09:07,571 DEBUG : BROWSER_OUTPUT: Values: 324.2 324.9 327.5 328.0 334.7 14814.4 15261.0 16133.5 16152.7 16703.4 15368.5 15410.8 15592.8 15703.8 15704.8 4509.1 4648.4 4649.4 4650.9 4657.3 4516.3 4582.7 4585.3 4587.9 4592.6 4583.2 4721.0 4904.5 5031.9 5063.4 4978.3 4985.0 4995.5 5004.1 5014.4 4947.5 4960.7 5002.9 5012.9 5016.9 11339.9 11435.3 13307.0 18609.6 18634.0 1817.1 1845.3 1856.5 1881.8 1996.5 8782.4 9017.0 11568.7 12686.3 12903.4 1631.5 1742.4 1749.4 1763.2 1817.1 55386.9 55597.4 56117.2 56816.7 56905.1 9507.5 9660.4 9687.8 9689.4 9736.3 12409.8 12456.6 12465.5 12475.8 12490.1 6747.9 6865.3 6899.6 7026.1 7121.1 6450.8 6451.0 6469.2 6538.9 6539.7 4085.0 4094.9 4096.5 4113.4 4165.3 1725.5 1751.2 1759.1 1761.7 1783.9 789.9 926.6 931.1 964.4 1014.1 14475.6 14571.3 14881.3 15086.3 16318.9 835.7 878.3 884.8 890.9 916.2 9092.5 9094.3 9108.2 9194.6 9294.5 410608.0 414320.0 426912.0 426959.0 427858.0 69830.7 70825.3 71803.6 71971.0 72704.6 1059.3 1060.8 1069.5 1082.2 1085.9 13673.5 14258.6 14396.2 14505.3 14542.2 32558.3 32924.7 33311.3 34149.5 35809.5 41154.8 41197.8 42011.4 42504.3 43803.3 8889.1 9097.3 9162.5 9165.7 9182.2 10611.8 12366.5 16901.0 16943.5 16958.6 13776.7 14073.6 14230.4 14252.9 14295.9 13494.7 13823.7 13968.4 14100.1 14210.8 14179.6 14385.3 14513.4 14590.1 14723.7 8996.1 9151.0 9162.9 9175.3 9175.7 13385.4 13410.7 13607.3 13650.2 13992.9 18:09:07 INFO - 2015-12-17 18:09:07,571 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,571 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4888.69 Median:6238.88 stddev:2537.90 (40.7%) stddev-sans-first:2532.18 18:09:07 INFO - 2015-12-17 18:09:07,573 DEBUG : BROWSER_OUTPUT: Values: 1491.7 1636.3 1667.8 1689.0 1704.6 6981.9 6983.9 7061.0 7185.5 7213.2 7155.7 7159.4 7224.5 7226.9 7271.9 2030.2 2078.2 2086.7 2091.0 2092.4 2055.1 2074.7 2079.5 2095.0 2099.3 1990.7 2010.7 2036.0 2036.0 2045.2 2036.1 2041.4 2059.3 2062.2 2065.9 1985.4 2024.9 2034.9 2035.1 2037.3 7034.9 7211.8 7213.4 7215.4 7219.8 3955.8 3995.1 4018.4 4030.0 4053.1 2656.4 2670.1 2718.7 2727.2 2732.9 819.7 820.9 871.2 889.2 893.7 9422.7 9472.0 9472.5 9478.7 9493.8 3589.6 3650.0 3664.5 3669.0 3700.7 7814.9 7838.7 7843.9 7852.4 7878.6 4044.5 4057.5 4062.8 4069.6 4079.8 3728.2 3749.9 3754.8 3770.0 3778.7 3063.8 3087.7 3093.2 3117.6 3135.1 883.4 892.7 927.5 930.8 930.9 903.1 903.9 921.7 973.8 1216.7 6550.9 6611.9 6632.5 6633.5 6672.9 937.3 1014.1 1033.9 1043.4 1057.2 5087.9 5103.1 5138.5 5146.0 5151.4 7981.6 8425.6 8425.7 8435.1 8462.7 8259.4 8261.3 8334.6 8379.0 8383.4 6437.8 6517.6 6527.7 6552.8 6579.8 6237.8 6259.3 6298.3 6320.4 6333.6 7303.0 7419.6 7440.3 7518.7 7532.7 7459.5 7637.4 7641.6 7671.9 7678.1 5846.3 5875.0 5891.9 5899.5 5901.9 6696.5 6956.5 6996.2 7001.5 7007.5 5805.5 6456.9 6498.6 6608.3 6723.4 5569.4 6491.0 6527.5 6623.0 6631.3 6200.1 6230.7 6231.3 6240.0 6258.2 6107.8 6130.3 6138.1 6141.6 6153.5 5975.8 5989.8 5998.4 6008.3 6018.8 18:09:07 INFO - 2015-12-17 18:09:07,573 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,573 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4846.15 Median:5596.84 stddev:1449.47 (25.9%) stddev-sans-first:1412.80 18:09:07 INFO - 2015-12-17 18:09:07,573 DEBUG : BROWSER_OUTPUT: Values: 299.6 305.5 306.5 309.3 310.1 5552.0 5582.3 5598.9 5669.8 5765.5 5554.8 5594.7 5604.5 5605.6 5634.6 4269.6 4301.5 4306.3 4308.5 4317.8 4304.9 4316.4 4326.7 4329.1 4332.0 4112.4 4196.7 4219.2 4270.9 4279.0 4202.4 4220.4 4224.8 4231.3 4244.5 3664.5 3670.6 3676.6 3681.6 3687.4 5374.2 5390.2 5403.3 5415.5 5417.0 4670.8 4762.4 4875.6 4880.1 4892.3 5854.9 5856.9 5860.2 5867.1 5871.1 4013.5 4017.7 4024.7 4025.5 4029.9 6079.8 6129.4 6180.5 6180.7 6182.6 3969.4 4052.6 4063.2 4140.5 4141.8 4097.5 4109.9 4114.4 4124.6 4131.5 4771.3 4813.0 4820.2 4824.8 4826.4 5834.0 5835.9 5839.2 5876.4 5880.6 1443.4 1465.8 1469.6 1470.5 1474.9 961.1 985.5 997.3 998.2 1003.6 5099.4 5102.3 5108.4 5111.1 5114.5 6059.0 6067.4 6094.2 6103.1 6103.8 5060.1 5083.0 5093.8 5106.2 5109.6 3223.5 3280.0 3283.2 3298.3 3299.6 5725.2 5726.0 5733.5 5737.7 5739.9 6226.2 6227.2 6229.8 6235.3 6240.3 5551.6 5618.7 5690.1 5697.2 5745.0 6123.8 6156.2 6158.7 6167.7 6174.1 5987.3 5989.7 5997.0 6004.8 6008.7 5629.7 5758.4 5768.7 5780.9 5782.0 4168.0 4171.9 4179.1 4183.6 4185.5 6124.8 6134.6 6135.7 6138.1 6143.0 5891.0 5891.0 5892.4 5897.8 5902.4 5748.6 5894.6 5896.3 5902.8 5915.5 5757.2 5767.9 5772.6 5784.8 5788.3 5906.7 5923.4 5937.3 5941.4 5950.8 5656.8 5766.5 5778.6 5789.0 5796.8 18:09:07 INFO - 2015-12-17 18:09:07,574 DEBUG : BROWSER_OUTPUT: 18:09:07 INFO - 2015-12-17 18:09:07,574 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11567.85 Median:558.36 stddev:13329.28 (2387.2%) stddev-sans-first:13341.71 18:09:07 INFO - 2015-12-17 18:09:07,575 DEBUG : BROWSER_OUTPUT: Values: 706.1 715.5 715.7 726.4 753.2 11339.7 11644.7 11675.9 11680.5 11694.9 9446.4 10569.9 10944.3 10984.5 11007.8 779.2 793.4 794.7 795.4 796.6 772.2 776.8 781.1 784.3 784.3 821.7 824.6 828.2 829.5 829.7 817.5 817.8 818.0 818.6 818.9 606.4 607.7 609.3 610.4 611.4 9780.2 9794.9 9864.0 9865.3 9877.5 8870.7 9275.6 9598.5 9608.2 9729.0 8221.4 8340.0 8347.4 8369.7 8395.6 3076.7 3176.2 3185.7 3185.8 3193.6 36879.8 37352.8 37461.4 37555.4 39013.0 8417.9 8463.6 8591.4 8707.9 8736.3 15026.9 15063.5 15086.8 15089.7 15141.9 6063.2 6168.2 6256.4 6326.1 6352.8 3529.8 3541.2 3559.4 3566.9 3617.1 2443.9 2478.5 2479.6 2483.1 2484.1 451.0 452.5 455.5 455.7 461.4 430.7 486.3 550.0 555.4 558.2 6673.2 6890.3 7014.1 7115.3 7207.5 545.5 551.5 555.9 558.0 558.5 3306.2 3321.3 3384.9 3386.5 3431.0 47675.5 47723.5 48207.3 48237.5 48303.0 42546.4 42550.0 43061.1 43614.3 43691.6 38644.6 39211.8 39850.0 39980.6 40494.0 7152.7 7222.3 7476.9 7534.1 7699.7 30604.0 30689.2 31291.8 31697.8 31750.2 36172.1 36430.0 36838.0 39373.2 39727.8 9432.7 9594.7 10001.8 10021.6 10057.3 10185.1 10202.2 10630.3 10680.7 10815.4 9379.2 9672.0 9781.9 9808.4 10224.5 9815.2 9948.7 10076.4 10187.7 10193.7 9596.9 9896.2 9967.0 9983.4 10133.4 7856.6 7964.2 8058.2 8086.7 8099.2 7984.0 8343.4 8368.0 8449.4 8481.7 18:09:07 INFO - 2015-12-17 18:09:07,575 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:09:07 INFO - 2015-12-17 18:09:07,575 DEBUG : BROWSER_OUTPUT: 18:09:08 INFO - 2015-12-17 18:09:08,308 INFO : Browser exited with error code: 0 18:09:08 INFO - 2015-12-17 18:09:08,327 INFO : Completed test dromaeo_css (00:18:34) 18:09:08 INFO - 2015-12-17 18:09:08,327 INFO : Starting test kraken 18:09:08 INFO - 2015-12-17 18:09:08,327 DEBUG : operating with platform_type : linux_ 18:09:08 INFO - 2015-12-17 18:09:08,327 INFO : Initialising browser for kraken test... 18:09:08 INFO - 2015-12-17 18:09:08,333 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQt8HL/profile http://localhost:56503/getInfo.html 18:09:12 INFO - 2015-12-17 18:09:12,938 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:09:12 INFO - 2015-12-17 18:09:12,938 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:09:12 INFO - 2015-12-17 18:09:12,938 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:09:12 INFO - 2015-12-17 18:09:12,938 DEBUG : BROWSER_OUTPUT: __metrics 18:09:13 INFO - 2015-12-17 18:09:13,067 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:09:13 INFO - 2015-12-17 18:09:13,981 INFO : Browser initialized. 18:09:13 INFO - 2015-12-17 18:09:13,981 INFO : Running cycle 1/1 for kraken test... 18:09:13 INFO - 2015-12-17 18:09:13,981 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQt8HL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:09:25 INFO - 2015-12-17 18:09:25,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 151347200 18:09:25 INFO - 2015-12-17 18:09:25,994 DEBUG : BROWSER_OUTPUT: 18:09:28 INFO - 2015-12-17 18:09:28,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56503/tests/kraken/driver.html?testName=audio-beat-detection) 18:09:29 INFO - 2015-12-17 18:09:29,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 150872064 18:09:29 INFO - 2015-12-17 18:09:29,190 DEBUG : BROWSER_OUTPUT: 18:09:31 INFO - 2015-12-17 18:09:31,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56503/tests/kraken/driver.html?testName=audio-dft) 18:09:32 INFO - 2015-12-17 18:09:32,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 151699456 18:09:32 INFO - 2015-12-17 18:09:32,521 DEBUG : BROWSER_OUTPUT: 18:09:35 INFO - 2015-12-17 18:09:35,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56503/tests/kraken/driver.html?testName=audio-fft) 18:09:36 INFO - 2015-12-17 18:09:36,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 145047552 18:09:36 INFO - 2015-12-17 18:09:36,006 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-12-17 18:09:38,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56503/tests/kraken/driver.html?testName=audio-oscillator) 18:09:38 INFO - 2015-12-17 18:09:38,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 146100224 18:09:38 INFO - 2015-12-17 18:09:38,693 DEBUG : BROWSER_OUTPUT: 18:09:40 INFO - 2015-12-17 18:09:40,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56503/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:09:41 INFO - 2015-12-17 18:09:41,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 146878464 18:09:41 INFO - 2015-12-17 18:09:41,529 DEBUG : BROWSER_OUTPUT: 18:09:44 INFO - 2015-12-17 18:09:44,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56503/tests/kraken/driver.html?testName=imaging-darkroom) 18:09:45 INFO - 2015-12-17 18:09:45,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 146341888 18:09:45 INFO - 2015-12-17 18:09:45,161 DEBUG : BROWSER_OUTPUT: 18:09:48 INFO - 2015-12-17 18:09:48,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56503/tests/kraken/driver.html?testName=imaging-desaturate) 18:09:49 INFO - 2015-12-17 18:09:49,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 145256448 18:09:49 INFO - 2015-12-17 18:09:49,246 DEBUG : BROWSER_OUTPUT: 18:09:52 INFO - 2015-12-17 18:09:52,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56503/tests/kraken/driver.html?testName=json-parse-financial) 18:09:52 INFO - 2015-12-17 18:09:52,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 146288640 18:09:52 INFO - 2015-12-17 18:09:52,808 DEBUG : BROWSER_OUTPUT: 18:09:54 INFO - 2015-12-17 18:09:54,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56503/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:09:55 INFO - 2015-12-17 18:09:55,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 148533248 18:09:55 INFO - 2015-12-17 18:09:55,171 DEBUG : BROWSER_OUTPUT: 18:09:57 INFO - 2015-12-17 18:09:57,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56503/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:09:57 INFO - 2015-12-17 18:09:57,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 147738624 18:09:57 INFO - 2015-12-17 18:09:57,672 DEBUG : BROWSER_OUTPUT: 18:09:59 INFO - 2015-12-17 18:09:59,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56503/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:10:00 INFO - 2015-12-17 18:10:00,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 147714048 18:10:00 INFO - 2015-12-17 18:10:00,418 DEBUG : BROWSER_OUTPUT: 18:10:02 INFO - 2015-12-17 18:10:02,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:10:03 INFO - 2015-12-17 18:10:03,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 147562496 18:10:03 INFO - 2015-12-17 18:10:03,587 DEBUG : BROWSER_OUTPUT: 18:10:06 INFO - 2015-12-17 18:10:06,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:10:06 INFO - 2015-12-17 18:10:06,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 149147648 18:10:06 INFO - 2015-12-17 18:10:06,811 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56503/tests/kraken/driver.html?testName=ai-astar) 18:10:08 INFO - 2015-12-17 18:10:08,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 147734528 18:10:08 INFO - 2015-12-17 18:10:08,840 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,843 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:10:08 INFO - 2015-12-17 18:10:08,843 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:10:08 INFO - 2015-12-17 18:10:08,843 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:10:08 INFO - 2015-12-17 18:10:08,843 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:10:08 INFO - 2015-12-17 18:10:08,844 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;109;115;113;114;125;114;113;114;114 18:10:08 INFO - 2015-12-17 18:10:08,844 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;130;151;164;134;152;156;132;167;132 18:10:08 INFO - 2015-12-17 18:10:08,844 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;163;162;162;163;172;165;163;163 18:10:08 INFO - 2015-12-17 18:10:08,844 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;78;73;130;73;73;73;72;89 18:10:08 INFO - 2015-12-17 18:10:08,844 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;136;95;94;96;134;95;96;127 18:10:08 INFO - 2015-12-17 18:10:08,845 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;111;110;109;109;109;110;110 18:10:08 INFO - 2015-12-17 18:10:08,845 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;148;148;148;148;149;148;146 18:10:08 INFO - 2015-12-17 18:10:08,845 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;98;96;98;96;95;96;96;96;97;95 18:10:08 INFO - 2015-12-17 18:10:08,845 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;72;73;72;72;73;72;70;70 18:10:08 INFO - 2015-12-17 18:10:08,845 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;71;68;73;68;68;68;68;70 18:10:08 INFO - 2015-12-17 18:10:08,846 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;82;86;84;83;83;85;86;84;83 18:10:08 INFO - 2015-12-17 18:10:08,846 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;129;138;119;126;122;122;132;127 18:10:08 INFO - 2015-12-17 18:10:08,846 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;154;152;151;147;161;148;149;150;138 18:10:08 INFO - 2015-12-17 18:10:08,846 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;69;72;74;69;70;68;72;68 18:10:08 INFO - 2015-12-17 18:10:08,846 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:10:08 INFO - 2015-12-17 18:10:08,846 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:10:08 INFO - 2015-12-17 18:10:08,846 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,788 18:10:08 INFO - 2015-12-17 18:10:08,847 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:10:08 INFO - 2015-12-17 18:10:08,847 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404608842__endTimestamp 18:10:08 INFO - 2015-12-17 18:10:08,847 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,850 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:10:08 INFO - 2015-12-17 18:10:08,850 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:10:08 INFO - 2015-12-17 18:10:08,850 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,850 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.10 (3.6%) stddev-sans-first:4.28 18:10:08 INFO - 2015-12-17 18:10:08,850 DEBUG : BROWSER_OUTPUT: Values: 117.0 109.0 115.0 113.0 114.0 125.0 114.0 113.0 114.0 114.0 18:10:08 INFO - 2015-12-17 18:10:08,850 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.80 Median:151.50 stddev:13.85 (9.1%) stddev-sans-first:14.65 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: Values: 150.0 130.0 151.0 164.0 134.0 152.0 156.0 132.0 167.0 132.0 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.92 (1.8%) stddev-sans-first:3.10 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 163.0 162.0 162.0 163.0 172.0 165.0 163.0 163.0 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:73.00 stddev:18.22 (25.0%) stddev-sans-first:19.01 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 78.0 73.0 130.0 73.0 73.0 73.0 72.0 89.0 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:18.18 (19.1%) stddev-sans-first:18.74 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 136.0 95.0 94.0 96.0 134.0 95.0 96.0 127.0 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 111.0 110.0 109.0 109.0 109.0 110.0 110.0 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,851 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 148.0 148.0 148.0 148.0 149.0 148.0 146.0 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.06 (1.1%) stddev-sans-first:0.93 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: Values: 98.0 96.0 98.0 96.0 95.0 96.0 96.0 96.0 97.0 95.0 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.20 Median:72.50 stddev:1.40 (1.9%) stddev-sans-first:1.32 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 72.0 73.0 72.0 72.0 73.0 72.0 70.0 70.0 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.00 stddev:1.85 (2.7%) stddev-sans-first:1.83 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 71.0 68.0 73.0 68.0 68.0 68.0 68.0 70.0 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.37 (1.6%) stddev-sans-first:1.41 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: Values: 83.0 82.0 86.0 84.0 83.0 83.0 85.0 86.0 84.0 83.0 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.50 stddev:5.77 (4.6%) stddev-sans-first:5.83 18:10:08 INFO - 2015-12-17 18:10:08,852 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 129.0 138.0 119.0 126.0 122.0 122.0 132.0 127.0 18:10:08 INFO - 2015-12-17 18:10:08,853 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,853 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:150.50 stddev:7.47 (5.0%) stddev-sans-first:6.12 18:10:08 INFO - 2015-12-17 18:10:08,853 DEBUG : BROWSER_OUTPUT: Values: 135.0 154.0 152.0 151.0 147.0 161.0 148.0 149.0 150.0 138.0 18:10:08 INFO - 2015-12-17 18:10:08,853 DEBUG : BROWSER_OUTPUT: 18:10:08 INFO - 2015-12-17 18:10:08,853 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:1.95 (2.8%) stddev-sans-first:2.05 18:10:08 INFO - 2015-12-17 18:10:08,853 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 72.0 74.0 69.0 70.0 68.0 72.0 68.0 18:10:08 INFO - 2015-12-17 18:10:08,853 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:10:08 INFO - 2015-12-17 18:10:08,853 DEBUG : BROWSER_OUTPUT: 18:10:09 INFO - 2015-12-17 18:10:09,828 INFO : Browser exited with error code: 0 18:10:09 INFO - 2015-12-17 18:10:09,882 INFO : Completed test kraken (00:01:01) 18:10:09 INFO - 2015-12-17 18:10:09,882 INFO : Starting test v8_7 18:10:09 INFO - 2015-12-17 18:10:09,882 DEBUG : operating with platform_type : linux_ 18:10:09 INFO - 2015-12-17 18:10:09,882 INFO : Initialising browser for v8_7 test... 18:10:09 INFO - 2015-12-17 18:10:09,888 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyM3vzj/profile http://localhost:56503/getInfo.html 18:10:14 INFO - 2015-12-17 18:10:14,488 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:10:14 INFO - 2015-12-17 18:10:14,488 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:10:14 INFO - 2015-12-17 18:10:14,488 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:10:14 INFO - 2015-12-17 18:10:14,489 DEBUG : BROWSER_OUTPUT: __metrics 18:10:14 INFO - 2015-12-17 18:10:14,637 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:10:15 INFO - 2015-12-17 18:10:15,568 INFO : Browser initialized. 18:10:15 INFO - 2015-12-17 18:10:15,569 INFO : Running cycle 1/1 for v8_7 test... 18:10:15 INFO - 2015-12-17 18:10:15,569 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyM3vzj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:10:27 INFO - 2015-12-17 18:10:27,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 150827008 18:10:27 INFO - 2015-12-17 18:10:27,582 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56503/tests/v8_7/run.html (next: http://localhost:56503/tests/v8_7/run.html) 18:10:49 INFO - 2015-12-17 18:10:49,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 145727488 18:10:49 INFO - 2015-12-17 18:10:49,262 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,262 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:10:49 INFO - 2015-12-17 18:10:49,262 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:10:49 INFO - 2015-12-17 18:10:49,262 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:10:49 INFO - 2015-12-17 18:10:49,262 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:10:49 INFO - 2015-12-17 18:10:49,262 DEBUG : BROWSER_OUTPUT: |0;Richards;164.88046166529267 18:10:49 INFO - 2015-12-17 18:10:49,262 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.49434242255612 18:10:49 INFO - 2015-12-17 18:10:49,263 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 18:10:49 INFO - 2015-12-17 18:10:49,263 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 18:10:49 INFO - 2015-12-17 18:10:49,263 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 18:10:49 INFO - 2015-12-17 18:10:49,263 DEBUG : BROWSER_OUTPUT: |5;Earley;716.8458781362007 18:10:49 INFO - 2015-12-17 18:10:49,263 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 18:10:49 INFO - 2015-12-17 18:10:49,263 DEBUG : BROWSER_OUTPUT: |7;RegExp;26153.846153846152 18:10:49 INFO - 2015-12-17 18:10:49,263 DEBUG : BROWSER_OUTPUT: |8;Splay;592.4170616113744 18:10:49 INFO - 2015-12-17 18:10:49,263 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404649260__endTimestamp 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.88 Median:164.88 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: Values: 164.9 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.49 Median:185.49 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: Values: 185.5 18:10:49 INFO - 2015-12-17 18:10:49,264 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,265 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,265 DEBUG : BROWSER_OUTPUT: Values: 278.1 18:10:49 INFO - 2015-12-17 18:10:49,265 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,265 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,265 DEBUG : BROWSER_OUTPUT: Values: 5196.9 18:10:49 INFO - 2015-12-17 18:10:49,266 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,266 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,266 DEBUG : BROWSER_OUTPUT: Values: 1056.0 18:10:49 INFO - 2015-12-17 18:10:49,266 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,266 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.85 Median:716.85 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: Values: 716.8 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: Values: 12219.5 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: Values: 26153.8 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:592.42 Median:592.42 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: Values: 592.4 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: Values: 4840.6 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:10:49 INFO - 2015-12-17 18:10:49,267 DEBUG : BROWSER_OUTPUT: 18:10:50 INFO - 2015-12-17 18:10:50,169 INFO : Browser exited with error code: 0 18:10:50 INFO - 2015-12-17 18:10:50,187 INFO : Completed test v8_7 (00:00:40) 18:10:50 INFO - 2015-12-17 18:10:50,275 INFO : Completed test suite (00:20:16) 18:10:50 INFO - 2015-12-17 18:10:50,275 DEBUG : Working with test: dromaeo_css 18:10:50 INFO - 2015-12-17 18:10:50,275 DEBUG : Generating results file: dromaeo_css 18:10:50 INFO - 2015-12-17 18:10:50,277 DEBUG : Working with test: kraken 18:10:50 INFO - 2015-12-17 18:10:50,277 DEBUG : Generating results file: kraken 18:10:50 INFO - 2015-12-17 18:10:50,277 INFO : javascript benchmark 18:10:50 INFO - 2015-12-17 18:10:50,277 DEBUG : Working with test: v8_7 18:10:50 INFO - 2015-12-17 18:10:50,277 DEBUG : Generating results file: v8_7 18:10:50 INFO - 2015-12-17 18:10:50,278 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:10:50 INFO - 2015-12-17 18:10:50,338 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 18:10:50 INFO - 2015-12-17 18:10:50,338 DEBUG : process_Request line: dromaeo_css 6275.21 graph.html#tests=[[72,132,43]] 18:10:50 INFO - 2015-12-17 18:10:50,338 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:10:50 INFO - 2015-12-17 18:10:50,385 DEBUG : process_Request line: kraken 1535.70 graph.html#tests=[[232,132,43]] 18:10:50 INFO - 2015-12-17 18:10:50,385 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:10:50 INFO - 2015-12-17 18:10:50,431 DEBUG : process_Request line: v8_7 21420.94 graph.html#tests=[[230,132,43]] 18:10:50 INFO - 2015-12-17 18:10:50,432 INFO : javascript benchmark 18:10:50 INFO - 2015-12-17 18:10:50,436 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2679.022156912727, 2717.904873329434, 2756.779457643389, 2767.1975127213104, 2767.501849667059, 4635.907281854369, 4750.643701722367, 4774.498677638846, 4813.2780082987565, 4848.127337079329, 4702.24764037754, 4709.963807962243, 4721.575058244757, 4855.2959820826045, 4855.5872750816225, 4367.519572846984, 4473.753943533105, 4546.227141385956, 4551.385562949009, 4578.5650363215445, 4435.201663700533, 4480.52954439784, 4508.752018638974, 4531.932021019671, 4594.931076033846, 4218.303979843353, 4321.330193819963, 4490.079533695584, 4512.729236245836, 4567.931481027787, 4317.15815415994, 4415.735055896656, 4423.955760442419, 4436.55634436557, 4440.422745043156, 4359.302511598129, 4398.186335527937, 4432.955670443286, 4441.467023957146, 4483.820647174109, 4485.618722408566, 4631.444226692818, 4646.79089440976, 4686.2267725825195, 4701.0, 5094.490550944913, 5135.255387968761, 5144.254083157921, 5148.819791307324, 5158.2520534522655, 5152.871178220537, 5178.974105129488, 5181.533661970403, 5189.299444574972, 5216.504432078947, 4655.998960223535, 4743.075100355398, 4784.234522476457, 4784.545468180518, 4798.856034318976, 5188.403333616607, 5219.869503262449, 5239.711815850165, 5249.0, 5314.335708036496, 5045.091883461012, 5047.520485553867, 5047.621428392885, 5054.039732450822, 5088.414832294259, 4945.455999840015, 5063.670861393997, 5066.06277838601, 5125.8718532037, 5206.76569554371, 5129.102407078821, 5139.691618502902, 5140.177571588602, 5161.2516185152945, 5176.171812510056, 5100.413452452941, 5107.846764597068, 5112.437631860493, 5129.281900533928, 5175.353080864892, 4108.979455102765, 4144.5233798113, 4224.4930608327195, 4243.533211346749, 4254.127903779779, 3692.7968961707365, 3693.649103335179, 3702.5927148013698, 3734.6638802507905, 3741.6819570336284, 4236.872893813191, 4427.070315233773, 4434.445694288214, 4442.844500442469, 4462.308342206963, 5095.668781529189, 5123.180291153398, 5149.588032957355, 5156.04613146569, 5220.034293655686, 4455.108978204307, 4461.665375096881, 4475.1049790042125, 4478.462584489882, 4501.7974191161475, 4355.934660980088, 4573.5426457354, 4594.425696787902, 4608.769561521911, 4627.6529260305615, 4766.0, 4801.5438533339275, 4888.682235654671, 4904.975475122745, 4947.060058588857, 5169.147090729987, 5176.741162941763, 5180.430152683127, 5199.7140157291715, 5205.687658740488, 4694.7887345068875, 4826.444958829779, 4894.461609222912, 4899.31409602663, 4925.975370123269, 4983.127952608352, 5068.239764035424, 5077.593792496666, 5086.338775959101, 5137.409197942285, 5114.820981265638, 5126.179811230334, 5129.563987061141, 5130.846074617767, 5148.30497882796, 4831.154547954024, 4889.242167463906, 4936.062148191976, 4980.327655766425, 4980.377452818398, 4992.80028798844, 5000.574951129195, 5020.774065167003, 5024.171011783161, 5027.4218464877, 4869.975650121868, 4916.803327866988, 4944.381952255968, 4951.1088004158155, 4973.6269779765935, 4851.345068415719, 4871.561559459666, 4971.328870602422, 5015.623828212972, 5089.491050895029, 4924.704517728947, 4939.580135688507, 4942.752862356796, 4953.133201689762, 5007.37407824022], "unit": "score", "name": "dojo.html", "value": 4703.715154985607}, {"lowerIsBetter": false, "replicates": [568.7582777319641, 569.4874612848436, 585.5023230254285, 587.6885250817065, 588.3763210996347, 34861.3027739445, 35171.824140879326, 35299.82350088246, 35314.11714707134, 35473.113172170706, 39834.601653983525, 40043.0, 40381.59618403815, 40440.191196176056, 40556.188876222455, 7753.651085701143, 7937.761867143995, 7942.523448593074, 7949.046114466272, 7961.681532738684, 7879.487833290817, 7978.760637180894, 7988.320992715626, 7989.161138080505, 7991.840163196733, 7942.205779422041, 8021.919780802175, 8026.117127116013, 8032.3574114071025, 8042.235987581171, 7961.641726122339, 8016.959915200445, 8034.678612855479, 8066.637001334954, 8094.676212951475, 7890.80272993174, 7953.244441778022, 8013.67945282188, 8024.398170137263, 8025.95987020067, 36494.0, 36750.081247969014, 36907.81546092279, 36917.446238306446, 36944.26111477782, 2802.8178168418985, 2839.2334069801245, 2999.505081661523, 3483.372992861284, 3597.5862775780856, 27181.45637087267, 27509.587356189473, 27787.444251115066, 28055.43889122206, 28281.15156545307, 3378.679025492574, 3418.1454636340914, 3418.6581341865863, 3513.8067406292644, 3516.4022116240044, 220466.0, 221823.9999999984, 222146.0, 222405.0, 222470.0, 50568.49431505638, 50598.494015059376, 53031.73484132632, 53795.193072103946, 53844.0, 47044.0, 47179.5282047182, 47184.29223561649, 47277.527224728, 47290.76354618205, 12831.550895718605, 12897.0, 13060.542880999119, 13079.869201308056, 13152.079354445097, 10350.378977261389, 10520.316179448464, 10538.473076346305, 10544.683659490227, 10563.735906602396, 17395.130243487776, 17762.91118544399, 18539.07304634763, 18573.47104050226, 18610.0, 7501.0, 7690.46166768332, 7824.882626760603, 7875.763727088197, 7896.368290536858, 791.4855344026314, 920.346553946692, 1017.211660962745, 1057.8254587992894, 1062.573789846509, 25761.355966100997, 25861.612075818877, 25973.740262597512, 26127.738722612532, 26145.86249650016, 933.355984370782, 1009.7425156585024, 1045.383223897904, 1065.2702898514387, 1066.9253152279266, 13757.724845503235, 13829.446822127204, 13869.583912482642, 13893.722125557431, 14443.566692999228, 268368.0, 269914.0, 270538.0, 270794.0, 270818.0, 44591.0, 44789.77605111954, 44971.32543011857, 45058.77470612692, 45119.32321015187, 1251.217988757027, 1263.5198624522623, 1263.5261776833688, 1265.6645988812788, 1275.9681007974689, 26101.0, 26364.868175658998, 26468.0, 26670.59994100129, 26994.0, 38706.0, 38844.41733374058, 39101.6089839098, 39169.0, 39169.41245881371, 253205.0, 253413.0, 253758.0, 253784.0, 256324.0, 27603.171904842886, 30558.541621875243, 31016.689833102282, 31029.224269392544, 31217.375652486367, 36159.27681446409, 36313.55021272975, 36837.44743828791, 37194.256114878095, 37388.439173411876, 31113.688863111078, 31411.214719632193, 31500.0, 32198.678013219567, 32365.838170808995, 31330.530042048933, 31653.84173079212, 31787.68212317847, 32098.0, 32205.35589288248, 31459.37081258316, 31825.363492730477, 31866.840665796524, 31880.36239275155, 32122.19694507656, 26550.336241594116, 28750.0, 30799.497240286142, 32632.34735305328, 32802.17994550155, 22104.66842997324, 22186.77813221847, 22243.22148724787, 22313.553728925654, 22444.0], "unit": "score", "name": "ext.html", "value": 16723.4889950322}, {"lowerIsBetter": false, "replicates": [324.2428928452064, 324.8700519792083, 327.4727688421641, 328.0045063233087, 334.74726581431014, 14814.407423703053, 15261.0, 16133.515994520169, 16152.676946461093, 16703.415380461687, 15368.538943831674, 15410.845891541081, 15592.766108508353, 15703.764443533357, 15704.764428533552, 4509.0530988492455, 4648.372469716579, 4649.39557857478, 4650.906981860361, 4657.32468792025, 4516.277395616702, 4582.679212455129, 4585.3122031695175, 4587.885302867422, 4592.586667199951, 4583.152116858375, 4720.952790472085, 4904.509549045085, 5031.899362012758, 5063.367079115111, 4978.253262010691, 4984.975075124601, 4995.475475075137, 5004.074246264435, 5014.423341315741, 4947.505249475023, 4960.727160006199, 5002.874928126789, 5012.874678133039, 5016.924746128811, 11339.943300283529, 11435.313881167156, 13307.0, 18609.62780744391, 18634.0, 1817.1380076379755, 1845.280340667141, 1856.5173055005662, 1881.7930027696943, 1996.5208349996042, 8782.429142105742, 9016.954915225382, 11568.652940411801, 12686.302253376061, 12903.419346129447, 1631.5350125214256, 1742.442418426104, 1749.448923589078, 1763.2141216877303, 1817.0642119308566, 55386.892262154935, 55597.444025560035, 56117.158242625985, 56816.715916420566, 56905.14642280369, 9507.477088760184, 9660.420374777535, 9687.757806054906, 9689.370190937707, 9736.318457707892, 12409.75180496385, 12456.564020259248, 12465.501379944883, 12475.812862807064, 12490.12569120171, 6747.865042699119, 6865.27914568973, 6899.6205208713, 7026.051483049825, 7121.074260346122, 6450.8064758057335, 6451.0, 6469.223693156757, 6538.934610653928, 6539.738410463623, 4084.9795751021056, 4094.8566800161852, 4096.549379568245, 4113.4446849675505, 4165.250254954077, 1725.5168552805235, 1751.20320254284, 1759.0676941221172, 1761.6652835961127, 1783.8662100342526, 789.8578255913991, 926.6339795780764, 931.1247427418206, 964.4165280005636, 1014.102519270451, 14475.565733028026, 14571.271436428136, 14881.33034013472, 15086.321115549827, 16318.918405407898, 835.6796261906173, 878.3412440669498, 884.752269364579, 890.9198172164537, 916.1845957098188, 9092.454452732858, 9094.317926155565, 9108.18026377616, 9194.586243619053, 9294.535273236312, 410608.0, 414320.0, 426912.0, 426959.0, 427858.0, 69830.65084674544, 70825.2917470829, 71803.64098179476, 71971.0, 72704.63647681728, 1059.3167407022581, 1060.7666313411037, 1069.4813015687384, 1082.155918383662, 1085.92398532102, 13673.453061877413, 14258.643533911736, 14396.20820854863, 14505.347259373142, 14542.200178990257, 32558.34883302368, 32924.67075329216, 33311.333773324885, 34149.48775768415, 35809.46285805663, 41154.79422602868, 41197.79401102975, 42011.36982945319, 42504.3256261564, 43803.34294985514, 8889.111088891059, 9097.317701172571, 9162.496062716615, 9165.725028249164, 9182.219511341611, 10611.787764244826, 12366.505339786667, 16901.0, 16943.491695249162, 16958.57603559921, 13776.65558361049, 14073.577792666236, 14230.359633816295, 14252.928735356258, 14295.857041429868, 13494.66263343385, 13823.654408639864, 13968.441262349392, 14100.08349457282, 14210.786838197642, 14179.64550886236, 14385.28073596337, 14513.419463221353, 14590.051646642934, 14723.705525889636, 8996.055414181417, 9151.0, 9162.862557061782, 9175.311851611023, 9175.678851240174, 13385.397657105259, 13410.664733381744, 13607.251601162032, 13650.249236292098, 13992.930035350166], "unit": "score", "name": "jquery.html", "value": 8214.594909331965}, {"lowerIsBetter": false, "replicates": [1491.7314883320998, 1636.2636813433955, 1667.7998640163182, 1688.9577760555992, 1704.6420251747134, 6981.860362792748, 6983.860322793554, 7061.0, 7185.46109041822, 7213.206547279795, 7155.7137714491355, 7159.427245820335, 7224.458165637585, 7226.855462890739, 7271.90921361796, 2030.2285131649953, 2078.158345869925, 2086.6765651324067, 2091.027672132458, 2092.3827470896044, 2055.1162999910034, 2074.6680531115026, 2079.5217100066993, 2095.0, 2099.2757498663013, 1990.661587530116, 2010.728551645531, 2035.989820050905, 2036.0328843799225, 2045.233037610896, 2036.0735865181382, 2041.397787652646, 2059.3101311060814, 2062.185436752482, 2065.917363305466, 1985.4043786863883, 2024.898755062241, 2034.8575599708026, 2035.1147250945885, 2037.3378651938178, 7034.859302813967, 7211.819704507377, 7213.386862116727, 7215.350618444365, 7219.783406497813, 3955.8417663293435, 3995.141044675409, 4018.4374187613757, 4030.0, 4053.108316170438, 2656.3890305229907, 2670.0788228061288, 2718.660167479065, 2727.154582079562, 2732.9180124596296, 819.6844214977276, 820.9425340226187, 871.2289623683023, 889.226373055446, 893.7050773244814, 9422.717318480456, 9471.952640236823, 9472.479013654178, 9478.715638530855, 9493.810123797555, 3589.5513060867393, 3649.978006158227, 3664.523611930432, 3669.046048027532, 3700.685441737429, 7814.921850781419, 7838.725644602411, 7843.882341764878, 7852.411069169835, 7878.606069696492, 4044.4742183515955, 4057.5130984282073, 4062.756234625932, 4069.593040695907, 4079.796010199478, 3728.217074414349, 3749.868754593631, 3754.8498060077836, 3769.98210483168, 3778.7165962552917, 3063.754899608026, 3087.706667866549, 3093.1648454917495, 3117.610298712661, 3135.0908236611585, 883.3772190605607, 892.6697122064877, 927.4759760735163, 930.8464103422995, 930.948797816113, 903.1375036839802, 903.8689390038408, 921.7050543825911, 973.8344481438172, 1216.7140721930339, 6550.934490655128, 6611.933880661132, 6632.535722499475, 6633.4693224541925, 6672.899906501407, 937.2876613773445, 1014.0974532665933, 1033.9017793309624, 1043.446973104256, 1057.1965306367217, 5087.923681144785, 5103.10695628271, 5138.460461651547, 5145.974270128625, 5151.4333423323405, 7981.640826162837, 8425.578721063923, 8425.747227583182, 8435.11431299717, 8462.746117616482, 8259.42184047123, 8261.297789687824, 8334.583270836434, 8378.958105209435, 8383.413161078666, 6437.806865794034, 6517.641529715911, 6527.738890444329, 6552.770653027121, 6579.80260592183, 6237.750489980532, 6259.280182778856, 6298.275698294571, 6320.4311611955145, 6333.556651034383, 7302.96348518254, 7419.629018549159, 7440.330370266702, 7518.661660225193, 7532.698692052257, 7459.515131516434, 7637.427192960661, 7641.617919104134, 7671.923280767121, 7678.1170165431695, 5846.269216347957, 5875.0, 5891.852703682271, 5899.528037757055, 5901.881962360814, 6696.4977626679165, 6956.513044086865, 6996.230414654486, 7001.474889383215, 7007.544509606859, 5805.477507024219, 6456.870862582628, 6498.642574658439, 6608.306127856506, 6723.361280678328, 5569.359523654832, 6490.967545162244, 6527.477801775752, 6623.0, 6631.270560238467, 6200.131981522501, 6230.6884655766125, 6231.345708700703, 6240.0, 6258.155149054819, 6107.786227482017, 6130.264368275835, 6138.140660307471, 6141.570090093651, 6153.507719382528, 5975.790847320323, 5989.8203053908455, 5998.430149135826, 6008.279006519246, 6018.759249629966], "unit": "score", "name": "mootools.html", "value": 4006.446771959208}, {"lowerIsBetter": false, "replicates": [299.5566561488996, 305.4562878077022, 306.49734435525727, 309.2624091541673, 310.051243195821, 5552.0, 5582.27430434043, 5598.936202121594, 5669.773209071637, 5765.5099316558035, 5554.750036248369, 5594.748236329365, 5604.467575580314, 5605.635633683808, 5634.633748806325, 4269.594388533084, 4301.548337424572, 4306.310990241562, 4308.547602501739, 4317.848875289365, 4304.880731009945, 4316.352547117926, 4326.675499337546, 4329.069250111225, 4332.0, 4112.424260603518, 4196.664266858659, 4219.198352313051, 4270.871873843789, 4278.978605106986, 4202.390653355277, 4220.366944958281, 4224.767637779921, 4231.259529582311, 4244.469441319835, 3664.486971823947, 3670.5778835434, 3676.5955744868043, 3681.6134305897763, 3687.4468829675493, 5374.247605335257, 5390.1914712793005, 5403.2705584745945, 5415.48552887475, 5416.9729151353995, 4670.789814458358, 4762.357081793948, 4875.561199492063, 4880.097182021337, 4892.315075889378, 5854.912176317359, 5856.912146317809, 5860.179574859523, 5867.093194711736, 5871.060630299132, 4013.518377794683, 4017.7388469749667, 4024.6981476389096, 4025.4766880305665, 4029.8589549365925, 6079.787207447763, 6129.356417576179, 6180.474659653934, 6180.721867515973, 6182.598131121463, 3969.364901615728, 4052.63526282636, 4063.227986682521, 4140.523839758406, 4141.81361838718, 4097.545371393172, 4109.8972525686495, 4114.423980642712, 4124.608162224584, 4131.5042194936195, 4771.284307353855, 4812.989272252796, 4820.156472617278, 4824.831130910401, 4826.396700412449, 5834.0, 5835.883282334329, 5839.211706419664, 5876.382979787061, 5880.647161170344, 1443.4370595467776, 1465.8167729033871, 1469.6472846516758, 1470.529430582225, 1474.9262536873327, 961.0869673809908, 985.4727720669407, 997.3218211616171, 998.1814911772277, 1003.5985605757755, 5099.4390617032095, 5102.311187989648, 5108.412532558729, 5111.131107711698, 5114.462981386975, 6058.969705151534, 6067.393260673985, 6094.2077529920825, 6103.084537319438, 6103.755849766048, 5060.114479965991, 5083.0, 5093.770780314895, 5106.234064890296, 5109.616778741609, 3223.5325877747596, 3279.967200327966, 3283.1627934876456, 3298.2578919742864, 3299.6040475143136, 5725.227094342294, 5725.971370143123, 5733.455321744427, 5737.655740655574, 5739.942600573941, 6226.221722284715, 6227.221597300338, 6229.844253893689, 6235.345288744707, 6240.282367527792, 5551.583631227593, 5618.6628802272, 5690.089585666274, 5697.173909783141, 5745.0, 6123.755049797958, 6156.199694039746, 6158.692065396802, 6167.660778657217, 6174.073888916699, 5987.31145918225, 5989.7304621293015, 5997.0404735242155, 6004.759809607742, 6008.699565021819, 5629.718514074198, 5758.424157584208, 5768.711564421678, 5780.913286300793, 5781.971090144522, 4167.97916010418, 4171.916561668689, 4179.080602267496, 4183.581641835792, 4185.497740271187, 6124.846878828065, 6134.631922084689, 6135.723892424762, 6138.07928810682, 6143.017117261216, 5891.0, 5891.026506120497, 5892.351841297368, 5897.7935772247765, 5902.350741418526, 5748.597598168088, 5894.557908156819, 5896.321922978912, 5902.793402230901, 5915.526757859275, 5757.165211044459, 5767.9134812977, 5772.5959182856795, 5784.797532086357, 5788.27646544182, 5906.675132867734, 5923.4076592340425, 5937.317208521075, 5941.405859414024, 5950.7917222896995, 5656.773729050792, 5766.481016708516, 5778.595498315246, 5788.971055144697, 5796.768129274782], "unit": "score", "name": "prototype.html", "value": 4374.399194917966}, {"lowerIsBetter": false, "replicates": [706.1428443194397, 715.4526787007939, 715.742332760206, 726.4442701333479, 753.2467532467532, 11339.659810205696, 11644.708882277948, 11675.949164575186, 11680.47437865296, 11694.941525292372, 9446.385984910994, 10569.894301056987, 10944.288621239613, 10984.505697243623, 11007.834882476749, 779.2402407652522, 793.4406243598278, 794.7218473534246, 795.4074214710021, 796.5658715999793, 772.2432016623712, 776.7863837444692, 781.0666253826679, 784.2667106255641, 784.2980532423478, 821.6959724901794, 824.5794644731201, 828.2421584250403, 829.4691397505601, 829.6515463505342, 817.5340056167987, 817.8159914019358, 818.0183779464636, 818.5907046476761, 818.8812622169781, 606.4026933470528, 607.74474720617, 609.2932198649589, 610.4109534299422, 611.4435863364317, 9780.217582593446, 9794.90205097947, 9863.950680246553, 9865.260105492116, 9877.506124693808, 8870.689525866628, 9275.58259878307, 9598.520073996342, 9608.231341492663, 9728.951355243178, 8221.383396245306, 8340.0, 8347.373946953941, 8369.665213391458, 8395.580220988926, 3076.661567227603, 3176.1583180457196, 3185.729213016896, 3185.7769956103084, 3193.6327322357993, 36879.81560092182, 37352.813235933645, 37461.438078428844, 37555.43666844972, 39013.0, 8417.915820841836, 8463.619137138843, 8591.398602097917, 8707.869381959275, 8736.301095912311, 15026.924865375822, 15063.472778452702, 15086.773698394532, 15089.698206035819, 15141.924290378478, 6063.242094738158, 6168.167297414881, 6256.4056414641445, 6326.114343991845, 6352.809415717536, 3529.7529172957647, 3541.15012397028, 3559.359315323215, 3566.892993210208, 3617.0595645132457, 2443.902243910259, 2478.5042991401792, 2479.615659572769, 2483.1184929350184, 2484.0808900706493, 450.9639228861683, 452.5203284518421, 455.51942700451343, 455.68102328370276, 461.39096392761235, 430.6576271863876, 486.2536007228887, 550.0, 555.4390066033254, 558.2073455692926, 6673.1992160941, 6890.276520965327, 7014.123234595676, 7115.324044215791, 7207.531510451909, 545.4817922973191, 551.5008916930185, 555.919391688203, 557.9868708971586, 558.5196730811499, 3306.173456635841, 3321.308928244511, 3384.933745870043, 3386.5428167197115, 3431.0, 47675.52324476711, 47723.52276477191, 48207.27689084667, 48237.517624824, 48303.0, 42546.36180457295, 42550.0, 43061.13877722491, 43614.34578481325, 43691.56308436939, 38644.6135538641, 39211.80394098011, 39849.99999999942, 39980.600193997685, 40494.0, 7152.749653762094, 7222.277772222946, 7476.925230747623, 7534.133574638987, 7699.6535155917, 30604.0, 30689.232769180056, 31291.84354078215, 31697.8415107923, 31750.206244844063, 36172.09569760777, 36430.0, 36838.0, 39373.21253574855, 39727.80136099301, 9432.669856554987, 9594.66418675343, 10001.849972250568, 10021.599136034478, 10057.29598928068, 10185.134263587383, 10202.234832387452, 10630.30902991303, 10680.732981675521, 10815.35107893529, 9379.155875971195, 9671.951640241754, 9781.902180978099, 9808.362456440309, 10224.53989570486, 9815.2147828175, 9948.651797187353, 10076.445795481319, 10187.7453063674, 10193.74515637115, 9596.9040309596, 9896.158826499828, 9967.0, 9983.400995940267, 10133.391996480235, 7856.607169641381, 7964.163762805054, 8058.194180581895, 8086.676532938616, 8099.230573095547, 7983.960080199562, 8343.41596088268, 8368.0, 8449.366297527587, 8481.745547633582], "unit": "score", "name": "yui.html", "value": 5391.277498947328}], "name": "dromaeo_css", "value": 6275.205396229395}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 109.0, 115.0, 113.0, 114.0, 125.0, 114.0, 113.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [150.0, 130.0, 151.0, 164.0, 134.0, 152.0, 156.0, 132.0, 167.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 163.0, 162.0, 162.0, 163.0, 172.0, 165.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 78.0, 73.0, 130.0, 73.0, 73.0, 73.0, 72.0, 89.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 136.0, 95.0, 94.0, 96.0, 134.0, 95.0, 96.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 111.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 98.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 72.0, 73.0, 72.0, 72.0, 73.0, 72.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 71.0, 68.0, 73.0, 68.0, 68.0, 68.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 86.0, 84.0, 83.0, 83.0, 85.0, 86.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 129.0, 138.0, 119.0, 126.0, 122.0, 122.0, 132.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [135.0, 154.0, 152.0, 151.0, 147.0, 161.0, 148.0, 149.0, 150.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 72.0, 74.0, 69.0, 70.0, 68.0, 72.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1535.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.88046166529267], "unit": "score", "name": "Richards", "value": 214.10663000000005}, {"lowerIsBetter": false, "replicates": [185.49434242255612], "unit": "score", "name": "DeltaBlue", "value": 356.44213800000017}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [716.8458781362007], "unit": "score", "name": "Earley", "value": 929.7158849999997}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [592.4170616113744], "unit": "score", "name": "Splay", "value": 137.55680799999996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21420.938807730578}]} 18:10:50 INFO - RETURN: dromaeo_css: 6275.21 18:10:50 INFO - RETURN: kraken: 1535.70 18:10:50 INFO - RETURN: v8_7: 21420.94 18:10:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21420.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1535.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6275.21"}}} 18:10:50 INFO - Return code: 0 18:10:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:10:50 INFO - # TBPL SUCCESS # 18:10:50 INFO - Running post-action listener: _resource_record_post_action 18:10:50 INFO - Running post-run listener: _resource_record_post_run 18:10:51 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 610304; Write bytes: 332226560; Read time: 208; Write time: 280240 18:10:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14204928; Read time: 0; Write time: 4812 18:10:51 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 610304; Write bytes: 318021632; Read time: 208; Write time: 275428 18:10:51 INFO - Running post-run listener: _upload_blobber_files 18:10:51 INFO - Blob upload gear active. 18:10:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:10:51 INFO - Copying logs to upload dir... 18:10:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.215010 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-17 18:10:51.689792) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 18:10:51.693419) ========= 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=a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009865 build_url: 'https://queue.taskcluster.net/v1/task/1MQLhGc_SZSWHVSzv6lh6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 18:10:51.748516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:10:51.749019) ========= 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=a9e534cca236dfa67d42a089000001c1-1450400416.274014-19621828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:10:51.799713) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 18:10:51.800336) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 18:10:51.800634) ========= ========= Total master_lag: 0.58 =========