builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1450664613.82 results: success (0) buildid: 20151220172928 builduid: aafdb45df99d47d89586b5c636a467f7 revision: ba5dfdb479515bbf0db38094cc8d4906457a63da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:33.817064) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:33.817502) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:33.817786) ========= 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=edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004997 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:33.882029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:33.882422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:33.941097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:33.944381) ========= 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=edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032520 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:34.006501) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:34.006766) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:34.007094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:34.010423) ========= 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=edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-20 18:23:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-20 18:23:34 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.248378 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:34.287441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:34.287800) ========= 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=edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.394703 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:34.697447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:34.697789) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba5dfdb479515bbf0db38094cc8d4906457a63da --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 ba5dfdb479515bbf0db38094cc8d4906457a63da --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=edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-20 18:23:35,156 truncating revision to first 12 chars 2015-12-20 18:23:35,156 Setting DEBUG logging. 2015-12-20 18:23:35,156 attempt 1/10 2015-12-20 18:23:35,156 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba5dfdb47951?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-20 18:23:35,398 unpacking tar archive at: fx-team-ba5dfdb47951/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527282 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:35.240028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:35.240495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:35.250987) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:35.251343) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 18:23:35.251749) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-20 18:23:35.252030) ========= /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=edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:23:35 INFO - MultiFileLogger online at 20151220 18:23:35 in /builds/slave/test 18:23:35 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 18:23:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:23:35 INFO - {'append_to_log': False, 18:23:35 INFO - 'base_work_dir': '/builds/slave/test', 18:23:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:23:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:23:35 INFO - 'branch': 'Fx-Team-Non-PGO', 18:23:35 INFO - 'buildbot_json_path': 'buildprops.json', 18:23:35 INFO - 'config_files': ('talos/linux_config.py',), 18:23:35 INFO - 'default_actions': ('clobber', 18:23:35 INFO - 'read-buildbot-config', 18:23:35 INFO - 'download-and-extract', 18:23:35 INFO - 'populate-webroot', 18:23:35 INFO - 'create-virtualenv', 18:23:35 INFO - 'install', 18:23:35 INFO - 'run-tests'), 18:23:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:23:35 INFO - 'download_minidump_stackwalk': True, 18:23:35 INFO - 'download_symbols': 'ondemand', 18:23:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:23:35 INFO - 'tooltool.py': '/tools/tooltool.py', 18:23:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:23:35 INFO - '/tools/misc-python/virtualenv.py')}, 18:23:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:23:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:23:35 INFO - 'installer_path': 'installer.exe', 18:23:35 INFO - 'log_level': 'info', 18:23:35 INFO - 'log_name': 'talos', 18:23:35 INFO - 'log_to_console': True, 18:23:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:23:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:23:35 INFO - 'opt_config_files': (), 18:23:35 INFO - 'pip_index': False, 18:23:35 INFO - 'sps_profile': False, 18:23:35 INFO - 'sps_profile_interval': 0, 18:23:35 INFO - 'suite': 'dromaeojs-e10s', 18:23:35 INFO - 'system_bits': '64', 18:23:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:23:35 INFO - 'title': 'talos-linux64-ix-063', 18:23:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:23:35 INFO - 'use_talos_json': True, 18:23:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:23:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:23:35 INFO - 'work_dir': 'build'} 18:23:35 INFO - ##### 18:23:35 INFO - ##### Running clobber step. 18:23:35 INFO - ##### 18:23:35 INFO - Running pre-action listener: _resource_record_pre_action 18:23:35 INFO - Running main action method: clobber 18:23:35 INFO - rmtree: /builds/slave/test/build 18:23:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:23:37 INFO - Running post-action listener: _resource_record_post_action 18:23:37 INFO - ##### 18:23:37 INFO - ##### Running read-buildbot-config step. 18:23:37 INFO - ##### 18:23:37 INFO - Running pre-action listener: _resource_record_pre_action 18:23:37 INFO - Running main action method: read_buildbot_config 18:23:37 INFO - Using buildbot properties: 18:23:37 INFO - { 18:23:37 INFO - "project": "", 18:23:37 INFO - "product": "firefox", 18:23:37 INFO - "script_repo_revision": "production", 18:23:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:23:37 INFO - "repository": "", 18:23:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:23:37 INFO - "buildid": "20151220172928", 18:23:37 INFO - "pgo_build": "False", 18:23:37 INFO - "basedir": "/builds/slave/test", 18:23:37 INFO - "buildnumber": 603, 18:23:37 INFO - "slavename": "talos-linux64-ix-063", 18:23:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:23:37 INFO - "platform": "ubuntu64_hw", 18:23:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:23:37 INFO - "branch": "fx-team", 18:23:37 INFO - "repo_path": "integration/fx-team", 18:23:37 INFO - "revision": "ba5dfdb479515bbf0db38094cc8d4906457a63da", 18:23:37 INFO - "stage_platform": "linux64", 18:23:37 INFO - "builduid": "aafdb45df99d47d89586b5c636a467f7", 18:23:37 INFO - "slavebuilddir": "test" 18:23:37 INFO - } 18:23:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:23:37 INFO - Running post-action listener: _resource_record_post_action 18:23:37 INFO - ##### 18:23:37 INFO - ##### Running download-and-extract step. 18:23:37 INFO - ##### 18:23:37 INFO - Running pre-action listener: _resource_record_pre_action 18:23:37 INFO - Running main action method: download_and_extract 18:23:37 INFO - mkdir: /builds/slave/test/build/tests 18:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:37 INFO - https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:23:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/test_packages.json 18:23:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/test_packages.json 18:23:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:23:40 INFO - Downloaded 1302 bytes. 18:23:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:23:40 INFO - Using the following test package requirements: 18:23:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:23:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:23:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:40 INFO - u'jsshell-linux-x86_64.zip'], 18:23:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:23:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:23:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:23:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:23:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:23:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:23:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:23:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:23: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')]} 18:23:40 INFO - https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/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 18:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/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 18:23:43 INFO - Downloaded 21872076 bytes. 18:23: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 18:23:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:23: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 18:23:44 INFO - Return code: 0 18:23:44 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 18:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:44 INFO - https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:23:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:23:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:23:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/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 18:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/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 18:23:45 INFO - Downloaded 21872076 bytes. 18:23:45 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 18:23:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:23:45 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 18:23:47 INFO - Return code: 0 18:23:47 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')]} 18:23:47 INFO - https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:23:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/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 18:23:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/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 18:23:48 INFO - Downloaded 11132039 bytes. 18:23:48 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 18:23:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:48 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 18:23:48 INFO - Return code: 0 18:23:48 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')]} 18:23:48 INFO - https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/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 18:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N7T_MxAaQSC1MH8YzhhpCw/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 18:23:50 INFO - Downloaded 53064426 bytes. 18:23:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:23:50 INFO - mkdir: /builds/slave/test/properties 18:23:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:23:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:23:50 INFO - Contents: 18:23:50 INFO - build_url:https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:23:50 INFO - Running post-action listener: _resource_record_post_action 18:23:50 INFO - Running post-action listener: set_extra_try_arguments 18:23:50 INFO - ##### 18:23:50 INFO - ##### Running populate-webroot step. 18:23:50 INFO - ##### 18:23:50 INFO - Running pre-action listener: _resource_record_pre_action 18:23:50 INFO - Running main action method: populate_webroot 18:23:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:23:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:23:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:23:50 INFO - '--tppagecycles', 18:23:50 INFO - '7'], 18:23:50 INFO - 'tests': ['tsvgm']}}, 18:23:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:23:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:23:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:23:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:23:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:50 INFO - 'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:50 INFO - 'tests': ['damp', 'tps']}, 18:23:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:50 INFO - 'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['damp', 'tps']}, 18:23:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:23:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:23:50 INFO - 'other': {'tests': ['a11yr', 18:23:50 INFO - 'ts_paint', 18:23:50 INFO - 'tpaint', 18:23:50 INFO - 'sessionrestore', 18:23:50 INFO - 'sessionrestore_no_auto_restore']}, 18:23:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['a11yr', 18:23:50 INFO - 'ts_paint', 18:23:50 INFO - 'tpaint', 18:23:50 INFO - 'sessionrestore', 18:23:50 INFO - 'sessionrestore_no_auto_restore']}, 18:23:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['a11yr', 18:23:50 INFO - 'ts_paint', 18:23:50 INFO - 'tpaint', 18:23:50 INFO - 'sessionrestore', 18:23:50 INFO - 'sessionrestore_no_auto_restore']}, 18:23:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['a11yr', 18:23:50 INFO - 'ts_paint', 18:23:50 INFO - 'tpaint', 18:23:50 INFO - 'sessionrestore', 18:23:50 INFO - 'sessionrestore_no_auto_restore']}, 18:23:50 INFO - 'other_l64': {'tests': ['a11yr', 18:23:50 INFO - 'ts_paint', 18:23:50 INFO - 'tpaint', 18:23:50 INFO - 'sessionrestore', 18:23:50 INFO - 'sessionrestore_no_auto_restore']}, 18:23:50 INFO - 'other_nol64': {'tests': ['a11yr', 18:23:50 INFO - 'ts_paint', 18:23:50 INFO - 'tpaint', 18:23:50 INFO - 'sessionrestore', 18:23:50 INFO - 'sessionrestore_no_auto_restore']}, 18:23:50 INFO - 'svgr': {'tests': ['tsvgx', 18:23:50 INFO - 'tsvgr_opacity', 18:23:50 INFO - 'tart', 18:23:50 INFO - 'tscrollx', 18:23:50 INFO - 'cart']}, 18:23:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['tsvgx', 18:23:50 INFO - 'tsvgr_opacity', 18:23:50 INFO - 'tart', 18:23:50 INFO - 'tscrollx', 18:23:50 INFO - 'cart']}, 18:23:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:50 INFO - 'tests': ['tp5o']}, 18:23:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:50 INFO - 'talos_options': ['--e10s'], 18:23:50 INFO - 'tests': ['tp5o']}, 18:23:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:50 INFO - 'talos_options': ['--xperf_path', 18:23:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:50 INFO - 'tests': ['tp5n']}, 18:23:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:50 INFO - 'talos_options': ['--e10s', 18:23:50 INFO - '--xperf_path', 18:23:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:50 INFO - 'tests': ['tp5n']}}, 18:23:50 INFO - 'talos.zip': {'path': '', 18:23:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:23:50 INFO - Running post-action listener: _resource_record_post_action 18:23:50 INFO - ##### 18:23:50 INFO - ##### Running create-virtualenv step. 18:23:50 INFO - ##### 18:23:50 INFO - Running pre-action listener: _resource_record_pre_action 18:23:50 INFO - Running main action method: create_virtualenv 18:23:50 INFO - Creating virtualenv /builds/slave/test/build/venv 18:23:50 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 18:23:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:23:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:23:50 INFO - Using real prefix '/usr' 18:23:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:23:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:23:54 INFO - Installing pip.................done. 18:23:54 INFO - Return code: 0 18:23:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:54 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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:23:54 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 18:23:54 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 18:23:54 INFO - Using env: {'DISPLAY': ':0', 18:23:54 INFO - 'HOME': '/home/cltbld', 18:23:54 INFO - 'LANG': 'en_US.UTF-8', 18:23:54 INFO - 'LANGUAGE': 'en_US:en', 18:23:54 INFO - 'LOGNAME': 'cltbld', 18:23:54 INFO - 'MAIL': '/var/mail/cltbld', 18:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:54 INFO - 'MOZ_NO_REMOTE': '1', 18:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:54 INFO - 'NO_EM_RESTART': '1', 18:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:54 INFO - 'PWD': '/builds/slave/test', 18:23:54 INFO - 'SHELL': '/bin/bash', 18:23:54 INFO - 'SHLVL': '1', 18:23:54 INFO - 'TERM': 'linux', 18:23:54 INFO - 'TMOUT': '86400', 18:23:54 INFO - 'USER': 'cltbld', 18:23:54 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:54 INFO - '_': '/tools/buildbot/bin/python'} 18:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23: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 18:23:55 INFO - Cleaning up... 18:23:55 INFO - Return code: 0 18:23:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:23: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 18:23: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 18:23:55 INFO - Using env: {'DISPLAY': ':0', 18:23:55 INFO - 'HOME': '/home/cltbld', 18:23:55 INFO - 'LANG': 'en_US.UTF-8', 18:23:55 INFO - 'LANGUAGE': 'en_US:en', 18:23:55 INFO - 'LOGNAME': 'cltbld', 18:23:55 INFO - 'MAIL': '/var/mail/cltbld', 18:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:55 INFO - 'MOZ_NO_REMOTE': '1', 18:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:55 INFO - 'NO_EM_RESTART': '1', 18:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:55 INFO - 'PWD': '/builds/slave/test', 18:23:55 INFO - 'SHELL': '/bin/bash', 18:23:55 INFO - 'SHLVL': '1', 18:23:55 INFO - 'TERM': 'linux', 18:23:55 INFO - 'TMOUT': '86400', 18:23:55 INFO - 'USER': 'cltbld', 18:23:55 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:55 INFO - '_': '/tools/buildbot/bin/python'} 18:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:55 INFO - Downloading/unpacking psutil>=0.7.1 18:23:55 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 18:23:55 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 18:23:55 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 18:23:55 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 18:23:55 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 18:23:55 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 18:23:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:23:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:23:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:57 INFO - Installing collected packages: psutil 18:23:57 INFO - Running setup.py install for psutil 18:23:57 INFO - building 'psutil._psutil_linux' extension 18:23: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 18:23: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 18:23:58 INFO - building 'psutil._psutil_posix' extension 18:23: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 18:23:59 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 18:23:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:59 INFO - Successfully installed psutil 18:23:59 INFO - Cleaning up... 18:23:59 INFO - Return code: 0 18:23:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:23: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 18:23: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 18:23:59 INFO - Using env: {'DISPLAY': ':0', 18:23:59 INFO - 'HOME': '/home/cltbld', 18:23:59 INFO - 'LANG': 'en_US.UTF-8', 18:23:59 INFO - 'LANGUAGE': 'en_US:en', 18:23:59 INFO - 'LOGNAME': 'cltbld', 18:23:59 INFO - 'MAIL': '/var/mail/cltbld', 18:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:59 INFO - 'MOZ_NO_REMOTE': '1', 18:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:59 INFO - 'NO_EM_RESTART': '1', 18:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:59 INFO - 'PWD': '/builds/slave/test', 18:23:59 INFO - 'SHELL': '/bin/bash', 18:23:59 INFO - 'SHLVL': '1', 18:23:59 INFO - 'TERM': 'linux', 18:23:59 INFO - 'TMOUT': '86400', 18:23:59 INFO - 'USER': 'cltbld', 18:23:59 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:59 INFO - '_': '/tools/buildbot/bin/python'} 18:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:24:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:24:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:24: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) 18:24:01 INFO - Installing collected packages: mozsystemmonitor 18:24:01 INFO - Running setup.py install for mozsystemmonitor 18:24:01 INFO - Successfully installed mozsystemmonitor 18:24:01 INFO - Cleaning up... 18:24:01 INFO - Return code: 0 18:24:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:24: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 18:24: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 18:24:01 INFO - Using env: {'DISPLAY': ':0', 18:24:01 INFO - 'HOME': '/home/cltbld', 18:24:01 INFO - 'LANG': 'en_US.UTF-8', 18:24:01 INFO - 'LANGUAGE': 'en_US:en', 18:24:01 INFO - 'LOGNAME': 'cltbld', 18:24:01 INFO - 'MAIL': '/var/mail/cltbld', 18:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:01 INFO - 'MOZ_NO_REMOTE': '1', 18:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:01 INFO - 'NO_EM_RESTART': '1', 18:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:01 INFO - 'PWD': '/builds/slave/test', 18:24:01 INFO - 'SHELL': '/bin/bash', 18:24:01 INFO - 'SHLVL': '1', 18:24:01 INFO - 'TERM': 'linux', 18:24:01 INFO - 'TMOUT': '86400', 18:24:01 INFO - 'USER': 'cltbld', 18:24:01 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:01 INFO - '_': '/tools/buildbot/bin/python'} 18:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:01 INFO - Downloading/unpacking blobuploader==1.2.4 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:03 INFO - Downloading blobuploader-1.2.4.tar.gz 18:24:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:24:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:24:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:04 INFO - Downloading docopt-0.6.1.tar.gz 18:24:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:24:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:24:04 INFO - Running setup.py install for blobuploader 18:24:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:24:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:24:04 INFO - Running setup.py install for requests 18:24:04 INFO - Running setup.py install for docopt 18:24:04 INFO - Successfully installed blobuploader requests docopt 18:24:04 INFO - Cleaning up... 18:24:04 INFO - Return code: 0 18:24:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:24: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 18:24: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 18:24:04 INFO - Using env: {'DISPLAY': ':0', 18:24:04 INFO - 'HOME': '/home/cltbld', 18:24:04 INFO - 'LANG': 'en_US.UTF-8', 18:24:04 INFO - 'LANGUAGE': 'en_US:en', 18:24:04 INFO - 'LOGNAME': 'cltbld', 18:24:04 INFO - 'MAIL': '/var/mail/cltbld', 18:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:04 INFO - 'MOZ_NO_REMOTE': '1', 18:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:04 INFO - 'NO_EM_RESTART': '1', 18:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:04 INFO - 'PWD': '/builds/slave/test', 18:24:04 INFO - 'SHELL': '/bin/bash', 18:24:04 INFO - 'SHLVL': '1', 18:24:04 INFO - 'TERM': 'linux', 18:24:04 INFO - 'TMOUT': '86400', 18:24:04 INFO - 'USER': 'cltbld', 18:24:04 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:04 INFO - '_': '/tools/buildbot/bin/python'} 18:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:04 INFO - Running setup.py (path:/tmp/pip-c1STFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:04 INFO - Running setup.py (path:/tmp/pip-pWQkne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:05 INFO - Running setup.py (path:/tmp/pip-3IWOWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:05 INFO - Running setup.py (path:/tmp/pip-nS6z2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:05 INFO - Running setup.py (path:/tmp/pip-FL8BIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:05 INFO - Running setup.py (path:/tmp/pip-vh4J54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:05 INFO - Running setup.py (path:/tmp/pip-wumHzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:05 INFO - Running setup.py (path:/tmp/pip-R_xNOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:05 INFO - Running setup.py (path:/tmp/pip-FWCHYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:05 INFO - Running setup.py (path:/tmp/pip-zPUmP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:05 INFO - Running setup.py (path:/tmp/pip-9Hpy0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:05 INFO - Running setup.py (path:/tmp/pip-PXWbv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:05 INFO - Running setup.py (path:/tmp/pip-YQ7_De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:05 INFO - Running setup.py (path:/tmp/pip-TXq9YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:05 INFO - Running setup.py (path:/tmp/pip-3qQl6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:05 INFO - Running setup.py (path:/tmp/pip-3eMfPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:06 INFO - Running setup.py (path:/tmp/pip-n0ZTYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:24:06 INFO - Running setup.py install for manifestparser 18:24:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Running setup.py install for mozcrash 18:24:06 INFO - Running setup.py install for mozdebug 18:24:06 INFO - Running setup.py install for mozdevice 18:24:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Running setup.py install for mozfile 18:24:06 INFO - Running setup.py install for mozhttpd 18:24:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Running setup.py install for mozinfo 18:24:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Running setup.py install for mozInstall 18:24:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:24:06 INFO - Running setup.py install for mozleak 18:24:07 INFO - Running setup.py install for mozlog 18:24:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:24:07 INFO - Running setup.py install for moznetwork 18:24:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:24:07 INFO - Running setup.py install for mozprocess 18:24:07 INFO - Running setup.py install for mozprofile 18:24:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:24:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:24:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:24:07 INFO - Running setup.py install for mozrunner 18:24:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:24:07 INFO - Running setup.py install for mozscreenshot 18:24:07 INFO - Running setup.py install for moztest 18:24:07 INFO - Running setup.py install for mozversion 18:24:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:24:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:24:07 INFO - Cleaning up... 18:24:07 INFO - Return code: 0 18:24:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:24: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 18:24: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 18:24:07 INFO - Using env: {'DISPLAY': ':0', 18:24:07 INFO - 'HOME': '/home/cltbld', 18:24:07 INFO - 'LANG': 'en_US.UTF-8', 18:24:07 INFO - 'LANGUAGE': 'en_US:en', 18:24:07 INFO - 'LOGNAME': 'cltbld', 18:24:07 INFO - 'MAIL': '/var/mail/cltbld', 18:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:07 INFO - 'MOZ_NO_REMOTE': '1', 18:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:07 INFO - 'NO_EM_RESTART': '1', 18:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:07 INFO - 'PWD': '/builds/slave/test', 18:24:07 INFO - 'SHELL': '/bin/bash', 18:24:07 INFO - 'SHLVL': '1', 18:24:07 INFO - 'TERM': 'linux', 18:24:07 INFO - 'TMOUT': '86400', 18:24:07 INFO - 'USER': 'cltbld', 18:24:07 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:07 INFO - '_': '/tools/buildbot/bin/python'} 18:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:08 INFO - Running setup.py (path:/tmp/pip-ZFmwyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:08 INFO - Running setup.py (path:/tmp/pip-OogChi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:08 INFO - Running setup.py (path:/tmp/pip-6CATC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:08 INFO - Running setup.py (path:/tmp/pip-1sXadX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:08 INFO - Running setup.py (path:/tmp/pip-MFx6ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:08 INFO - Running setup.py (path:/tmp/pip-Ryz2WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:08 INFO - Running setup.py (path:/tmp/pip-f3bZyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:08 INFO - Running setup.py (path:/tmp/pip-u4IufX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:08 INFO - Running setup.py (path:/tmp/pip-6pZTpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:08 INFO - Running setup.py (path:/tmp/pip-vhZMvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:08 INFO - Running setup.py (path:/tmp/pip-WNaioK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:08 INFO - Running setup.py (path:/tmp/pip-kNUfYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24: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)) 18:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:09 INFO - Running setup.py (path:/tmp/pip-wKj3M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24: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)) 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:09 INFO - Running setup.py (path:/tmp/pip-1GzwLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24: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)) 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:09 INFO - Running setup.py (path:/tmp/pip-dghyV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24: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)) 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:09 INFO - Running setup.py (path:/tmp/pip-PCdn7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24: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)) 18:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:09 INFO - Running setup.py (path:/tmp/pip-7rNgBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:11 INFO - Downloading blessings-1.5.1.tar.gz 18:24: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 18:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:24:11 INFO - Installing collected packages: blessings 18:24:11 INFO - Running setup.py install for blessings 18:24:11 INFO - Successfully installed blessings 18:24:11 INFO - Cleaning up... 18:24:11 INFO - Return code: 0 18:24:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:24:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:11 INFO - Reading from file tmpfile_stdout 18:24:11 INFO - Current package versions: 18:24:11 INFO - argparse == 1.2.1 18:24:11 INFO - blessings == 1.5.1 18:24:11 INFO - blobuploader == 1.2.4 18:24:11 INFO - docopt == 0.6.1 18:24:11 INFO - manifestparser == 1.1 18:24:11 INFO - mozInstall == 1.12 18:24:11 INFO - mozcrash == 0.16 18:24:11 INFO - mozdebug == 0.1 18:24:11 INFO - mozdevice == 0.47 18:24:11 INFO - mozfile == 1.2 18:24:11 INFO - mozhttpd == 0.7 18:24:11 INFO - mozinfo == 0.9 18:24:11 INFO - mozleak == 0.1 18:24:11 INFO - mozlog == 3.1 18:24:11 INFO - moznetwork == 0.27 18:24:11 INFO - mozprocess == 0.22 18:24:11 INFO - mozprofile == 0.27 18:24:11 INFO - mozrunner == 6.11 18:24:11 INFO - mozscreenshot == 0.1 18:24:11 INFO - mozsystemmonitor == 0.0 18:24:11 INFO - moztest == 0.7 18:24:11 INFO - mozversion == 1.4 18:24:11 INFO - psutil == 3.1.1 18:24:11 INFO - requests == 1.2.3 18:24:11 INFO - wsgiref == 0.1.2 18:24:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:24: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 18:24: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 18:24:11 INFO - Using env: {'DISPLAY': ':0', 18:24:11 INFO - 'HOME': '/home/cltbld', 18:24:11 INFO - 'LANG': 'en_US.UTF-8', 18:24:11 INFO - 'LANGUAGE': 'en_US:en', 18:24:11 INFO - 'LOGNAME': 'cltbld', 18:24:11 INFO - 'MAIL': '/var/mail/cltbld', 18:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:11 INFO - 'MOZ_NO_REMOTE': '1', 18:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:11 INFO - 'NO_EM_RESTART': '1', 18:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:11 INFO - 'PWD': '/builds/slave/test', 18:24:11 INFO - 'SHELL': '/bin/bash', 18:24:11 INFO - 'SHLVL': '1', 18:24:11 INFO - 'TERM': 'linux', 18:24:11 INFO - 'TMOUT': '86400', 18:24:11 INFO - 'USER': 'cltbld', 18:24:11 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:11 INFO - '_': '/tools/buildbot/bin/python'} 18:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24: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)) 18:24:11 INFO - Cleaning up... 18:24:11 INFO - Return code: 0 18:24:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:24: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 18:24: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 18:24:11 INFO - Using env: {'DISPLAY': ':0', 18:24:11 INFO - 'HOME': '/home/cltbld', 18:24:11 INFO - 'LANG': 'en_US.UTF-8', 18:24:11 INFO - 'LANGUAGE': 'en_US:en', 18:24:11 INFO - 'LOGNAME': 'cltbld', 18:24:11 INFO - 'MAIL': '/var/mail/cltbld', 18:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:11 INFO - 'MOZ_NO_REMOTE': '1', 18:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:11 INFO - 'NO_EM_RESTART': '1', 18:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:11 INFO - 'PWD': '/builds/slave/test', 18:24:11 INFO - 'SHELL': '/bin/bash', 18:24:11 INFO - 'SHLVL': '1', 18:24:11 INFO - 'TERM': 'linux', 18:24:11 INFO - 'TMOUT': '86400', 18:24:11 INFO - 'USER': 'cltbld', 18:24:11 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:11 INFO - '_': '/tools/buildbot/bin/python'} 18:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:11 INFO - Downloading/unpacking jsonschema 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:24: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 18:24:13 INFO - Downloading/unpacking functools32 (from jsonschema) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:24: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 18:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:24:13 INFO - warning: no files found matching '*.txt' 18:24:13 INFO - no previously-included directories found matching 'build' 18:24:13 INFO - no previously-included directories found matching 'dist' 18:24:13 INFO - no previously-included directories found matching '.git*' 18:24:14 INFO - Installing collected packages: jsonschema, functools32 18:24:14 INFO - Running setup.py install for functools32 18:24:14 INFO - warning: no files found matching '*.txt' 18:24:14 INFO - no previously-included directories found matching 'build' 18:24:14 INFO - no previously-included directories found matching 'dist' 18:24:14 INFO - no previously-included directories found matching '.git*' 18:24:14 INFO - Successfully installed jsonschema functools32 18:24:14 INFO - Cleaning up... 18:24:14 INFO - Return code: 0 18:24:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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 0x7f6ed22a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, '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': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', '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 18:24: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 18:24: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 18:24:14 INFO - Using env: {'DISPLAY': ':0', 18:24:14 INFO - 'HOME': '/home/cltbld', 18:24:14 INFO - 'LANG': 'en_US.UTF-8', 18:24:14 INFO - 'LANGUAGE': 'en_US:en', 18:24:14 INFO - 'LOGNAME': 'cltbld', 18:24:14 INFO - 'MAIL': '/var/mail/cltbld', 18:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:14 INFO - 'MOZ_NO_REMOTE': '1', 18:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:14 INFO - 'NO_EM_RESTART': '1', 18:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:14 INFO - 'PWD': '/builds/slave/test', 18:24:14 INFO - 'SHELL': '/bin/bash', 18:24:14 INFO - 'SHLVL': '1', 18:24:14 INFO - 'TERM': 'linux', 18:24:14 INFO - 'TMOUT': '86400', 18:24:14 INFO - 'USER': 'cltbld', 18:24:14 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:14 INFO - '_': '/tools/buildbot/bin/python'} 18:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:14 INFO - Downloading/unpacking flake8 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:24:16 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 18:24:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:24: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 18:24:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24: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 18:24:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:24:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:24:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:24:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:24:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:24:16 INFO - no previously-included directories found matching 'docs/_build' 18:24:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:24:16 INFO - Running setup.py install for pep8 18:24:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:24:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:24:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:24:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:24:16 INFO - no previously-included directories found matching 'docs/_build' 18:24:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:24:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:24:16 INFO - Cleaning up... 18:24:16 INFO - Return code: 0 18:24:16 INFO - Running post-action listener: _resource_record_post_action 18:24:16 INFO - Running post-action listener: _start_resource_monitoring 18:24:17 INFO - Starting resource monitoring. 18:24:17 INFO - ##### 18:24:17 INFO - ##### Running install step. 18:24:17 INFO - ##### 18:24:17 INFO - Running pre-action listener: _resource_record_pre_action 18:24:17 INFO - Running main action method: install 18:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:17 INFO - Reading from file tmpfile_stdout 18:24:17 INFO - Detecting whether we're running mozinstall >=1.0... 18:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:24:17 INFO - Reading from file tmpfile_stdout 18:24:17 INFO - Output received: 18:24:17 INFO - Usage: mozinstall [options] installer 18:24:17 INFO - Options: 18:24:17 INFO - -h, --help show this help message and exit 18:24:17 INFO - -d DEST, --destination=DEST 18:24:17 INFO - Directory to install application into. [default: 18:24:17 INFO - "/builds/slave/test"] 18:24:17 INFO - --app=APP Application being installed. [default: firefox] 18:24:17 INFO - mkdir: /builds/slave/test/build/application 18:24: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'] 18:24: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 18:24:32 INFO - Reading from file tmpfile_stdout 18:24:32 INFO - Output received: 18:24:32 INFO - /builds/slave/test/build/application/firefox/firefox 18:24:32 INFO - Running post-action listener: _resource_record_post_action 18:24:32 INFO - ##### 18:24:32 INFO - ##### Running run-tests step. 18:24:32 INFO - ##### 18:24:32 INFO - Running pre-action listener: _resource_record_pre_action 18:24:32 INFO - Running main action method: run_tests 18:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:24:32 INFO - Python 2.7.3 18:24:32 INFO - Return code: 0 18:24:32 INFO - grabbing minidump binary from tooltool 18:24: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')]} 18:24: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 0xf850b0>, '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 0xf85fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf86440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:24: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 18:24: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 18:24:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:24:32 INFO - Return code: 0 18:24:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:24:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:24:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:24:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:24:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:24:33 INFO - Return code: 0 18:24: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/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] in /builds/slave/test/build 18:24: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/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost 18:24:33 INFO - Using env: {'DISPLAY': ':0', 18:24:33 INFO - 'HOME': '/home/cltbld', 18:24:33 INFO - 'LANG': 'en_US.UTF-8', 18:24:33 INFO - 'LANGUAGE': 'en_US:en', 18:24:33 INFO - 'LOGNAME': 'cltbld', 18:24:33 INFO - 'MAIL': '/var/mail/cltbld', 18:24:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:24:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:33 INFO - 'MOZ_NO_REMOTE': '1', 18:24:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:33 INFO - 'NO_EM_RESTART': '1', 18:24:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:33 INFO - 'PWD': '/builds/slave/test', 18:24:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:24:33 INFO - 'SHELL': '/bin/bash', 18:24:33 INFO - 'SHLVL': '1', 18:24:33 INFO - 'TERM': 'linux', 18:24:33 INFO - 'TMOUT': '86400', 18:24:33 INFO - 'USER': 'cltbld', 18:24:33 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845', 18:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:33 INFO - '_': '/tools/buildbot/bin/python'} 18:24: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/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] with output_timeout 3600 18:24:34 INFO - mozversion INFO | application_buildid: 20151220172928 18:24:34 INFO - mozversion INFO | application_changeset: ba5dfdb479515bbf0db38094cc8d4906457a63da 18:24:34 INFO - mozversion INFO | application_display_name: Nightly 18:24:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:24:34 INFO - mozversion INFO | application_name: Firefox 18:24:34 INFO - mozversion INFO | application_remotingname: firefox 18:24:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:24:34 INFO - mozversion INFO | application_vendor: Mozilla 18:24:34 INFO - mozversion INFO | application_version: 46.0a1 18:24:34 INFO - mozversion INFO | platform_buildid: 20151220172928 18:24:34 INFO - mozversion INFO | platform_changeset: ba5dfdb479515bbf0db38094cc8d4906457a63da 18:24:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:24:34 INFO - mozversion INFO | platform_version: 46.0a1 18:24:34 INFO - 2015-12-20 18:24:34,560 DEBUG : using testdate: 1450664674 18:24:34 INFO - 2015-12-20 18:24:34,560 DEBUG : actual date: 1450664674 18:24:34 INFO - 2015-12-20 18:24:34,568 INFO : starting webserver on 'localhost:41155' 18:24:34 INFO - 2015-12-20 18:24:34,569 INFO : Starting test suite talos-linux64-ix-063.e 18:24:34 INFO - 2015-12-20 18:24:34,569 INFO : Starting test dromaeo_css 18:24:34 INFO - 2015-12-20 18:24:34,569 DEBUG : operating with platform_type : linux_ 18:24:34 INFO - 2015-12-20 18:24:34,569 INFO : Initialising browser for dromaeo_css test... 18:24:34 INFO - 2015-12-20 18:24:34,626 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphgy7Gd/profile http://localhost:41155/getInfo.html 18:24:38 INFO - 2015-12-20 18:24:38,833 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 18:24:39 INFO - 2015-12-20 18:24:39,898 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:24:39 INFO - 2015-12-20 18:24:39,898 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:24:39 INFO - 2015-12-20 18:24:39,898 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:24:39 INFO - 2015-12-20 18:24:39,899 DEBUG : BROWSER_OUTPUT: __metrics 18:24:40 INFO - 2015-12-20 18:24:40,020 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:24:40 INFO - 2015-12-20 18:24:40,926 INFO : Browser initialized. 18:24:40 INFO - 2015-12-20 18:24:40,926 INFO : Running cycle 1/1 for dromaeo_css test... 18:24:40 INFO - 2015-12-20 18:24:40,927 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphgy7Gd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:24:52 INFO - 2015-12-20 18:24:52,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 151355392 18:24:52 INFO - 2015-12-20 18:24:52,942 DEBUG : BROWSER_OUTPUT: 18:25:42 INFO - 2015-12-20 18:25:42,563 DEBUG : BROWSER_OUTPUT: 1450664742559 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] 18:27:54 INFO - 2015-12-20 18:27:54,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41155/tests/dromaeo/cssquery-ext.html) 18:27:55 INFO - 2015-12-20 18:27:55,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 155398144 18:27:55 INFO - 2015-12-20 18:27:55,584 DEBUG : BROWSER_OUTPUT: 18:30:57 INFO - 2015-12-20 18:30:57,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-ext.html (next: http://localhost:41155/tests/dromaeo/cssquery-jquery.html) 18:30:58 INFO - 2015-12-20 18:30:58,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 153747456 18:30:58 INFO - 2015-12-20 18:30:58,294 DEBUG : BROWSER_OUTPUT: 18:34:00 INFO - 2015-12-20 18:34:00,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41155/tests/dromaeo/cssquery-mootools.html) 18:34:00 INFO - 2015-12-20 18:34:00,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 154075136 18:34:00 INFO - 2015-12-20 18:34:00,656 DEBUG : BROWSER_OUTPUT: 18:37:02 INFO - 2015-12-20 18:37:02,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41155/tests/dromaeo/cssquery-prototype.html) 18:37:03 INFO - 2015-12-20 18:37:03,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 151470080 18:37:03 INFO - 2015-12-20 18:37:03,059 DEBUG : BROWSER_OUTPUT: 18:40:05 INFO - 2015-12-20 18:40:05,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41155/tests/dromaeo/cssquery-yui.html) 18:40:06 INFO - 2015-12-20 18:40:06,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 152969216 18:40:06 INFO - 2015-12-20 18:40:06,308 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-yui.html (next: http://localhost:41155/tests/dromaeo/cssquery-dojo.html) 18:43:08 INFO - 2015-12-20 18:43:08,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 156459008 18:43:08 INFO - 2015-12-20 18:43:08,853 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,853 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:43:08 INFO - 2015-12-20 18:43:08,853 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:43:08 INFO - 2015-12-20 18:43:08,853 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:43:08 INFO - 2015-12-20 18:43:08,853 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:43:08 INFO - 2015-12-20 18:43:08,857 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2618.2145356393085;2645.5370310195713;2687;2687.6102965070054;2708.485387776323;4413;4592.4718657354415;4645.18709225885;4651.511591282909;4665.813367465302;4509.075639493904;4522.14079324928;4584.816607335702;4677.883052923678;4701.388819453467;4229.661627069835;4275.508316543591;4298.742075475481;4315.848945286915;4359.520452750211;4221.514525829522;4301.5698430157045;4310.80601372939;4338.262495375794;4406.405135306724;4095.28332541804;4146.66826653867;4185;4291.699581029329;4311.396404503372;4285.078708077778;4308.655307575386;4308.719933204332;4316.223079845627;4329.7618630975285;4266.491956898328;4272.508661503935;4274.380214868826;4279.422277992462;4339.457567804025;4319.114581510814;4456.309272062803;4526.932096018562;4614.630829533629;4615.076984603093;4964.478729733398;4992.301077849104;4997.525235102659;5013.9972005598665;5035.571976382012;4970.701757894538;4997.0505603935135;5024.648274620778;5027.472115427864;5034.0686972910125;4417.403650507173;4512.706674066175;4624.445066591963;4675.883102922454;4748.287756836433;5023;5040.581375021793;5048.419431765394;5086.4659210783075;5087.8982420351385;4661.394018777537;4907.092187945242;4914.140025495524;4930.457649658535;4963.60291176705;4844.467108618049;4894.388201474816;4932.926006109911;4946.258061290763;4986.8753281168265;4902.607791376681;4903.803847846046;4912;4922.040202160616;4970.925436118461;4641.628669706415;4821.132196204647;4825.179719447702;4908.042931628298;4929.06347793918;4058.898527536835;4101.282275601758;4112.383142528644;4115.32097203964;4133.627973482341;3651.2149887773726;3653.2510835278704;3658.5426821647293;3673.2653469306247;3693.150575367627;4101.979490102531;4194.2869712148395;4215.241256573846;4301.870943871689;4318.913621727548;4945.67853089548;4949.010197960422;4951.752412379366;4958.132326842788;4975.427825800007;4261.126469073833;4267.637250833652;4274.252005899018;4289.592488713567;4310.956890431118;4174.624283814472;4259.105587826592;4342.848000320037;4346.673999450054;4430.933535996963;4692.272697731857;4732.881677958078;4739.289106633894;4744.027474367746;4754.358161648133;4973.45292017885;5012.799488020439;5016.54851063406;5032.823851165192;5056.191009438619;4445.488768791631;4543.386642803312;4673.415823022122;4795.424549054136;4816.8554943351755;4891.388576427947;4915.1644220481885;4926.236433352836;4946.901061978812;4978.477259887804;4709.7174169549935;4986.650934434555;4998.175301075282;4998.3252260945765;5039.395272567315;4740.905181896412;4748.192807222711;4811.687240329367;4823.855284341475;4853.199222128309;4754.809807607657;4798.376211092535;4804.615630749601;4838.927416088832;4875.293082503088;4511.887202819956;4659.464161621457;4700.788464519173;4726.19654658702;4791.496892826342;4716.103940251342;4754.690945088558;4762.9285560715925;4795.640326975421;4829.782659780389;4768.928466073081;4794.376731025084;4795.496472870298;4819.012102519046;4832.371791667061 18:43:08 INFO - 2015-12-20 18:43:08,857 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.5875149314797;550.6420826462796;566.0546886699212;579.4784693775603;588.299923091521;31542;31885.202869928264;31927.201819954513;32060.83969580152;32126.35747285053;36874.631253687454;37627.43558846613;37658.246835063284;37753.244935101284;37774.24451510968;7875.80310492238;8009.9587053683235;8017.95991020044;8027.197280271985;8058.153893841121;7758.961205193966;7832.490888092284;7841.960790196041;7873.173316801739;7896.565688887109;7840.255175758294;7902.170272121431;7988.520688758664;7993.880091798627;8000.359971202319;7881.251281128284;7887.408444366638;7901.525908445512;7971.720989765359;8008.959955200245;7789.143194248685;7926.524408535506;7932.2067793220795;7933.761987140395;7992.880106798345;36852.262954740756;37338.06654833624;37370.06574835624;37410;37412.25175496502;2879.2226098953374;3120.422721796475;3332.800191930903;3748.5689145748315;3786.2616789726017;27013;27216.31959201016;27488.58767118495;27610;27892.302692432648;3271.8854840080485;3484.216051388443;3494.109002204422;3539.8407071681836;3563.3051554946796;199216;200396;201323;201381;202600;52191.47808521866;55573;55658;56092.07355485159;56193.71903140458;44769.32846007313;67723.3227667717;68434.3156568428;69457.65271173611;69590.65204673944;13037.348132593332;13046.086773925734;13068.803967940488;13069.607911762663;13264.933675331562;10555.31390459633;10651.73370665724;10659.626913058006;10684.626038088629;10761.408122553335;19405.4178374649;19736.605267894563;19959.800401996086;19992.50018749543;19996.20015199376;7676.11724651661;7957.965464489579;7972;8049;8088.272055515032;864.6109250837148;865.2126564825978;893.8569828827357;1009.9192064634811;1070.9089727373105;25928.61107083395;29008.709912900602;29636.259093522403;30333;30808.537871931938;934.1359242700611;967.3760424526141;997.396575072071;1036.5905467340358;1083.160550573312;12808.551700690432;12852.678683032998;12857.678558036125;12895.548655797002;12962.416691248727;304813;311277;312214;312388;313930;46001.76999114983;46672.299915501295;46765.53234467612;46848.29727554089;46889.53110468852;1230.7476967221878;1248.444442223202;1249.6001279590625;1253.9623811285676;1266.3478308671042;23742.099994521282;24193.27420177327;24201.878990604935;24458.75541244636;24486.26541203767;37029.44455833219;37292.44061339028;37387.813060934524;37659.24681506409;37664.62335376611;244775;246490;247321;247647;247760;29647;42483;42638.10732740997;43629;43632.12735745331;36343.81828090949;36780.44829327509;37200.62799371972;37308.440373393874;37349.066273343386;31531.84234078815;36811.447828282064;38262.2347553053;38463.230735384575;38645.420318694676;31997.84001080073;32432.513512297806;32461.35077298488;32582.34835303328;37110.62889371072;32310;32659.510107347935;32860.83569582232;32946.17634559155;33016.33967320592;28702;29366.559501607066;29460.263493412836;29513.852430738567;29695.109146725634;23636.29091127269;23709.644355334338;23731.455896387204;24009.279721608378;24059.639105413084 18:43:08 INFO - 2015-12-20 18:43:08,860 DEBUG : BROWSER_OUTPUT: |2;jquery.html;314.60674157303373;317.5284702217207;320.19151642103685;324.33511301831226;325.38339845991845;12191.817122743167;12536.122471427003;15689.686206275868;16200.108994005324;16283.185840707962;11722.472488738005;11731.29612223265;11857.347845868473;14029.78955315671;14624.926875365634;4705.505921878204;4778.569928706424;4952.628552858532;4988.975055124719;5812.82561523155;5694.060480020791;6049.334573196967;6228;6242.87514249717;6247.937520624781;6053.334133245339;6223.937760622381;6517.543771935966;6553.803385898431;6565.244996825355;6437.742490300382;6452.064450654629;6487.351264873522;6489.61062336259;6519.087327774116;5891.851089037639;6091.208142941434;6094.268687757453;6096.451319381277;6100.115483254947;15476.690466190727;16817.83182168175;19285.710714339297;20352.18591256348;20363;1915.205189846212;1932.1305412564402;1955.9217631294732;1997.450910104754;2006.26771228502;13730.45078196871;13734.862651373458;13865.09876858001;13982.720345593132;14270.928645356811;1906.27561526619;1910.8566857485605;1912.407153782332;1931.2564662604857;1945.5525229197365;57268.713656431864;62578.37421625771;62863;63822.36177638257;64227.357726422604;14768.63078423048;15277.312520936584;15285.38858445672;15291.923540382228;15331.92334038345;23028.65457018146;23157.073717051127;23162.8841855793;23437.7656223439;23453.296401107993;8463.788405289793;8549.829003419896;8558.700445484377;8608.354373421893;8638.956805215934;6966.616836073963;6971.163460384685;6988.720451181997;6999.440044796404;7017;4034.5561988181275;4177.97911010443;4218.6414154797185;7443.8883416748795;7522.736704215436;1726.5856194513226;1735.670222657691;1751.6496700659918;1755.2013833705632;1804.2061492943062;809.4576633655465;819.2831272636444;896.7668406214301;932.5896605493562;977.7213494154132;15061.171635559931;15219.847801521842;15307.693846123015;15412.383504659689;15654.373825047098;858.6090533336036;868.5830801215452;870.6822009966444;877.9868301975475;888.9911100889037;8485.109063548362;8740.344474164463;8761.948566172101;8762.912370876336;8860.424072435271;489493;509584;521828;528542;540978;67671;70073;71029;71114.64442677857;71514.64242678753;1065.3554599467366;1077.1167642533205;1080.8270676691534;1103.0844399148848;1108.9168312376603;14269.363972828769;14357.641058973191;14400;14485.710285794436;14519.637009074857;29772;30045;30499.84750076324;31070.844645776626;31850;39525.2094958105;40039.79980100081;41810.58189418067;42918.78540607277;44623.10753784841;8497.74506764798;8677.913220867964;8817.603207855534;8845;8911;10350.809656889554;10508.264421490423;14904.85095149078;15379.76930346068;16079.196040198178;13321.467141314239;13381.933090334485;13398.9330053353;13613.86386136126;13846.861531384557;8756.868646970173;9397.483138427453;9558.856617150888;9853.901460985586;13467.663308417368;9495.572699228413;9661.661841835503;9729.124378805942;9757.756056098371;9834.950825245827;14010.649733756738;14112.858871411154;14699.191544465157;14725.484608038667;14810.333534990736;15043.924780376028;15069.924650376677;15277.576460356859;15423.537293881202;15458.768118478456 18:43:08 INFO - 2015-12-20 18:43:08,862 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1415.9433622655088;1423.7935499352593;1494.4993427201887;1660.5350501859477;1721.4491362763918;6775.898361524581;6957.304269573046;6966.442684585228;7054.1535015798045;7301.08736407949;7292.7447539336135;7324.63376831159;7360.227176146508;7395.482316237865;7400.407967362611;2028.3306508852081;2068.8655237409594;2079.563291708743;2080.167932826866;2082.1255072869358;2053.425040988526;2074.6058248932654;2084.7498300203997;2127.6595744680776;2128.4998025464;1688.4681325382464;1734.0549400576654;2029.4824819670964;2065.803748643884;2089.582083583289;2026.1186383922966;2030.8679935804125;2030.979690203094;2033.0241484087574;2041.2345370485918;2034.08466190215;2039.3983774786473;2137.8931053447263;2138.101997161196;2139.8609090409227;7151.642417879085;7173.89239161413;7232.74685386009;7236.167840698282;7238.203797582261;4125.257453658341;4182.477190351206;4199.2441360555085;4200.411942328076;4213.53651098382;2757.462294852505;2791.637087178674;2800.9859950700115;2808.129479861229;2845.2744550139582;930.2325581395309;941.9967734362882;961.0437614573474;963.5326866469757;970.2965350121176;9472.90527094727;9486.383385079947;9504.90495095054;9504.954455009944;9522.90477095234;3694.2057457646733;3714.832832522543;3785.299719551892;3794.127350709297;3816.160444702161;7807.141214466405;7829.7259595913865;7838.176991415933;7876.763697089096;7884.84230315402;4144.834206631761;4152.190322887008;4171.541130475645;4181.707280490336;4185.183889141588;3778.678812300985;3805.3911374179997;3810.371288737327;3822;3839.6928245740273;3051.3744682340066;3113.159446949356;3116.750659947199;3138.8116712997294;3154.9053528394184;932.8693982842408;945.2910317262053;954.2938225713061;956.5360800012128;961;851.5103815306223;874.2394117118021;931.65063101337;937.5499760115183;959.7264779537799;6482.870342593122;6528.543001989815;6546.9017964730565;6571.67141642916;6583.506237032242;576.7260551238128;585.096026638844;590.6633219065178;594.4946795224025;730.9305615966475;5151.974240128776;5209.166533354721;5209.270702101709;5238.5023422774775;5238.580913526908;8025.8394832104195;8652.956735216283;8697.739067827975;8716.43343182691;8719.171678690514;8484.854544636395;8532.786680333042;8542;8577.571121443903;8637.784055398539;6627.304133065959;6640.369164929324;6670.733170673216;6708.228553716288;6709.19489661234;6502.739890404331;6505.381988711065;6513.576617519846;6519.8044058678315;6561.442277406283;7429.925700742923;7670.194629564038;7712.537247765152;7713.652885620273;7731.072271327476;7350;7472.29013243741;7492.438067144877;7552.8489430212185;7840.451168418156;6375.458086062737;6381;6420.711068001858;6444.581102228341;6454.064160696579;6901.896471553031;6940.9652951734915;6949.965250173716;6958.851789454886;6974.965125174342;6350.936490635035;6505.447037001908;6529.053287273414;6691.866162676816;6781.321867813179;5653.265075540154;5710.2862142232225;6212.285587157535;6259.12372267892;6305.96847015762;6157.199564056644;6260.499160067275;6282.026285925689;6318.715657795502;6394.584352017104;5993.280806303272;6009.399060093956;6015.6691381974415;6020.488258498077;6025.487833534024;6025.096235564701;6170.043643235305;6170.3212646607935;6174.722137503733;6187.938120618736 18:43:08 INFO - 2015-12-20 18:43:08,865 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.82782158526464;301.434809731753;304.1059285700043;304.5219006160329;304.8841440252704;5548.056830338842;5569.860753481165;5589.323203039093;5669.631473954195;5750.108733146359;5577.163425486179;5611.102223644218;5622.072358060915;5637.069883469223;5640.802571909973;4292.441982542273;4313.029568347129;4321.416608757809;4332.176886391591;4333.631641310492;4291.442112525383;4315.4605674290715;4318.417013703157;4329.242382583036;4337.1325734853;4194.2869712149;4236.894077648068;4266.722663026909;4284.157812140778;4300.956990430102;4276.828926842923;4279.1227798301425;4283.250431174532;4287.742735435852;4298.4197133387215;3706.4440333949856;3711.9443208351895;3719.814009299524;3732.6640602345647;3734.402495600718;5454.53636440903;5465.371482279549;5466.371367292772;5469.753861076261;5473.124300112003;4701.64737644678;4933.161362568372;4936.728479933602;4940.752962351868;4941.308216849644;5688;5814.563907706939;5835.299764028344;5846.444587764198;5854.853628659318;3993.341098718708;3998.640122388999;3998.9200215995807;4002.0595160137345;4005.118873847749;6093.2078829751845;6162.722677479479;6163.322034576193;6167.735614199123;6167.999999999955;3939.2909276330533;4087.080406908422;4091.895188299143;4096.180763847183;4146.854860079883;4193.790310484464;4193.874183774492;4194.412782210493;4200.6219440250525;4205.222033923673;4847.297141914402;4851.927221091686;4852.223644216909;4855.393075865517;4858.902821943541;5837.153612726131;5865.266841644794;5874.148248504029;5886.852063847594;5891.234139561915;1421.1118051217989;1465.0330781684038;1490.754025585788;1491.6494623763624;1492.440334874422;978.1441238915949;983.6360546597662;1000.3197825478744;1000.6447711062614;1001.5543083327849;5053.747312634354;5064;5074.188129899198;5080;5091;6022.879542409128;6030.728617212236;6039.7282122304605;6039.8490037748525;6053.243344581927;5032.3961124665275;5043.142665746832;5055.216441451581;5083.771230294646;5087.516685914832;3225.209823593235;3244.8702051917658;3282.7373810095614;3290.3748287825238;3331.5502407175204;5778.711064446761;5779.942200578024;5789;5790.565707571865;5799.94200057994;6339.11252424661;6351.904721429182;6361.777337793247;6365.936340636535;6366.331535188739;5619.494245517923;5770.105633626795;5782.710864456844;5791.652500849962;5795.8551036224435;6157.32269450369;6159.96920015415;6172.259328880384;6177.536684748752;6181.258249010148;5997.220361352996;6000.909986350121;6014.759409623566;6017;6017.608855424383;5766.538676905753;5774.133879918046;5774.884502310014;5776.7111644418455;5790.652560846363;4065.430839682506;4114.415949859266;4159.792010399407;4164.479440069991;4168.499780026416;5957.642541447527;6142.324344322032;6151.169592105188;6154.323024467216;6163.137160797402;5935.703214839327;5943.465088142088;5946.583739138392;5969.164316995711;5980;5905.763769449174;5910.202122713378;5922.052471604523;5948.315943666534;5952.791652292149;5670.121131224501;5776.508996735324;5802.245708057925;5807.186993820784;5817.0983497557945;5973.761049557969;5974.044152935509;5988.850278743066;5997.310309314485;6004.369541198112;5763.250777399079;5831.912521312099;5834.445727655866;5841.386654401396;5858.648481090978 18:43:08 INFO - 2015-12-20 18:43:08,866 DEBUG : BROWSER_OUTPUT: |5;yui.html;675.4191395399956;739.4897520710707;776.8252143267769;781.5818537082658;788.9506955748855;10272.332298400599;10654.25420220583;10670.733231669212;10686.893131068688;10702.357858528483;11183.049440797522;11245.83131253032;11275.32348059115;11315.943420282907;11321.20751547392;622.0141076393899;630.2216762298558;785.4109417936547;793.4723408933053;796.1123347467561;797.5573556676043;808.5957021489255;810.7770363150122;814.9714759983402;815.7960509872532;835.2774849754979;839.1524560194187;841.6969890839293;843.3000609494105;844.2739244249971;832.1595188859266;833.9416240863112;834.2491757418311;834.6285902773268;835.2649668291925;621.2141640824361;622.6544267931297;622.757124721359;622.8287221014212;623.323693792236;11262.831057534144;11391.943040284828;11408.030317423028;11424.828627570592;11445.771084578346;10247.333923294962;10767.084797792197;10824.67525974222;10932.453377331101;11048.613298534512;8711.764617982377;8741.213290803795;8764.342674299452;8784.560771961376;8842.69050583233;3260.1523603863166;3297.3405318936307;3314.254292784104;3323.833808309575;3327.2680010397676;38146;38312.04219894497;38565;38580.80709596462;40212.59787402147;8511.659533618586;8554.743357699155;8741.082186370466;8768.561571921378;8811.33914956368;14746.852531474762;14756.114633121832;14764.040337378035;14765.187914664797;14782.778258325918;6105.8168254952425;6266.717997690115;6294.464970477469;6332.778352757631;6371.331010243857;3233.3210025894355;3255.8372081395837;3485.5991560970306;3558.5551806024246;3613.5663720353728;2609.556375416184;2612.2163350994624;2636.116900838202;2639.2741995950882;2649.986750066237;463.59203900567957;466.26795930388965;466.7666166916542;468.32561111998615;473.758383224558;551.5973339462215;555.7388027627089;562.8874225154985;564.8446677163813;579.0677010013874;6922.653867306614;7049.224585295613;7524.510906791041;7603.581803000778;7726.304632583095;522.634156090738;569.8657384385878;572.2017785189637;573.4695406748741;578.4909279833804;3283;3542.220711443478;3568.6966607838626;3627.691646210049;3673.577538583097;48582.75708621505;52470.21294680583;52570.73714631402;52641.21038184431;52666.47333526692;42435.1512969745;42611;42778.786106069274;43440;44678.10643787106;35575.4663680045;35960.64039359625;40651.390229146586;40663.79668101641;40745.79627101846;7429.665665044978;7608.733694320672;8159.632816523152;8285.295749861329;8294.502329860228;30481.54277685792;30653.23366915845;30769.38461230718;31716;31773.36453270968;37937.05157371088;38114.237715244984;38695;41553.376699348926;42006.36990445085;9147.63409463614;9188.816223675356;9210.263178945803;9478.95260523693;9557.569909354235;10923.508442120283;11015.228933974546;11073.612423565137;11075;11615.128865335302;9664.661736839176;9854.901450985399;9903.811542614932;10151.289409741246;10167;9628.807423851344;10140.188784897044;10366.502079391359;10439.686809395731;10457.843132353173;7987.001624796901;8740.431871928304;9912.256580756328;9916.355436896578;9998.850017249602;8144.30773384269;8176.672933082848;8363.163683631588;8489.06620271782;8629.13708629132;7354.852902942018;7574.697012119454;7721.4594978353225;7925.207479252029;8369.204925532065 18:43:08 INFO - 2015-12-20 18:43:08,866 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:43:08 INFO - 2015-12-20 18:43:08,866 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:43:08 INFO - 2015-12-20 18:43:08,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 18:43:08 INFO - 2015-12-20 18:43:08,866 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:43:08 INFO - 2015-12-20 18:43:08,866 DEBUG : BROWSER_OUTPUT: __startTimestamp1450665788852__endTimestamp 18:43:08 INFO - 2015-12-20 18:43:08,866 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:43:08 INFO - 2015-12-20 18:43:08,867 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:43:08 INFO - 2015-12-20 18:43:08,867 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,867 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4566.07 Median:4701.39 stddev:474.54 (10.1%) stddev-sans-first:450.72 18:43:08 INFO - 2015-12-20 18:43:08,868 DEBUG : BROWSER_OUTPUT: Values: 2618.2 2645.5 2687.0 2687.6 2708.5 4413.0 4592.5 4645.2 4651.5 4665.8 4509.1 4522.1 4584.8 4677.9 4701.4 4229.7 4275.5 4298.7 4315.8 4359.5 4221.5 4301.6 4310.8 4338.3 4406.4 4095.3 4146.7 4185.0 4291.7 4311.4 4285.1 4308.7 4308.7 4316.2 4329.8 4266.5 4272.5 4274.4 4279.4 4339.5 4319.1 4456.3 4526.9 4614.6 4615.1 4964.5 4992.3 4997.5 5014.0 5035.6 4970.7 4997.1 5024.6 5027.5 5034.1 4417.4 4512.7 4624.4 4675.9 4748.3 5023.0 5040.6 5048.4 5086.5 5087.9 4661.4 4907.1 4914.1 4930.5 4963.6 4844.5 4894.4 4932.9 4946.3 4986.9 4902.6 4903.8 4912.0 4922.0 4970.9 4641.6 4821.1 4825.2 4908.0 4929.1 4058.9 4101.3 4112.4 4115.3 4133.6 3651.2 3653.3 3658.5 3673.3 3693.2 4102.0 4194.3 4215.2 4301.9 4318.9 4945.7 4949.0 4951.8 4958.1 4975.4 4261.1 4267.6 4274.3 4289.6 4311.0 4174.6 4259.1 4342.8 4346.7 4430.9 4692.3 4732.9 4739.3 4744.0 4754.4 4973.5 5012.8 5016.5 5032.8 5056.2 4445.5 4543.4 4673.4 4795.4 4816.9 4891.4 4915.2 4926.2 4946.9 4978.5 4709.7 4986.7 4998.2 4998.3 5039.4 4740.9 4748.2 4811.7 4823.9 4853.2 4754.8 4798.4 4804.6 4838.9 4875.3 4511.9 4659.5 4700.8 4726.2 4791.5 4716.1 4754.7 4762.9 4795.6 4829.8 4768.9 4794.4 4795.5 4819.0 4832.4 18:43:08 INFO - 2015-12-20 18:43:08,868 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,868 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41595.65 Median:3516.97 stddev:67221.41 (1911.3%) stddev-sans-first:67339.32 18:43:08 INFO - 2015-12-20 18:43:08,868 DEBUG : BROWSER_OUTPUT: Values: 544.6 550.6 566.1 579.5 588.3 31542.0 31885.2 31927.2 32060.8 32126.4 36874.6 37627.4 37658.2 37753.2 37774.2 7875.8 8010.0 8018.0 8027.2 8058.2 7759.0 7832.5 7842.0 7873.2 7896.6 7840.3 7902.2 7988.5 7993.9 8000.4 7881.3 7887.4 7901.5 7971.7 8009.0 7789.1 7926.5 7932.2 7933.8 7992.9 36852.3 37338.1 37370.1 37410.0 37412.3 2879.2 3120.4 3332.8 3748.6 3786.3 27013.0 27216.3 27488.6 27610.0 27892.3 3271.9 3484.2 3494.1 3539.8 3563.3 199216.0 200396.0 201323.0 201381.0 202600.0 52191.5 55573.0 55658.0 56092.1 56193.7 44769.3 67723.3 68434.3 69457.7 69590.7 13037.3 13046.1 13068.8 13069.6 13264.9 10555.3 10651.7 10659.6 10684.6 10761.4 19405.4 19736.6 19959.8 19992.5 19996.2 7676.1 7958.0 7972.0 8049.0 8088.3 864.6 865.2 893.9 1009.9 1070.9 25928.6 29008.7 29636.3 30333.0 30808.5 934.1 967.4 997.4 1036.6 1083.2 12808.6 12852.7 12857.7 12895.5 12962.4 304813.0 311277.0 312214.0 312388.0 313930.0 46001.8 46672.3 46765.5 46848.3 46889.5 1230.7 1248.4 1249.6 1254.0 1266.3 23742.1 24193.3 24201.9 24458.8 24486.3 37029.4 37292.4 37387.8 37659.2 37664.6 244775.0 246490.0 247321.0 247647.0 247760.0 29647.0 42483.0 42638.1 43629.0 43632.1 36343.8 36780.4 37200.6 37308.4 37349.1 31531.8 36811.4 38262.2 38463.2 38645.4 31997.8 32432.5 32461.4 32582.3 37110.6 32310.0 32659.5 32860.8 32946.2 33016.3 28702.0 29366.6 29460.3 29513.9 29695.1 23636.3 23709.6 23731.5 24009.3 24059.6 18:43:08 INFO - 2015-12-20 18:43:08,869 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,869 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27911.79 Median:19925.30 stddev:84533.27 (424.3%) stddev-sans-first:84745.01 18:43:08 INFO - 2015-12-20 18:43:08,869 DEBUG : BROWSER_OUTPUT: Values: 314.6 317.5 320.2 324.3 325.4 12191.8 12536.1 15689.7 16200.1 16283.2 11722.5 11731.3 11857.3 14029.8 14624.9 4705.5 4778.6 4952.6 4989.0 5812.8 5694.1 6049.3 6228.0 6242.9 6247.9 6053.3 6223.9 6517.5 6553.8 6565.2 6437.7 6452.1 6487.4 6489.6 6519.1 5891.9 6091.2 6094.3 6096.5 6100.1 15476.7 16817.8 19285.7 20352.2 20363.0 1915.2 1932.1 1955.9 1997.5 2006.3 13730.5 13734.9 13865.1 13982.7 14270.9 1906.3 1910.9 1912.4 1931.3 1945.6 57268.7 62578.4 62863.0 63822.4 64227.4 14768.6 15277.3 15285.4 15291.9 15331.9 23028.7 23157.1 23162.9 23437.8 23453.3 8463.8 8549.8 8558.7 8608.4 8639.0 6966.6 6971.2 6988.7 6999.4 7017.0 4034.6 4178.0 4218.6 7443.9 7522.7 1726.6 1735.7 1751.6 1755.2 1804.2 809.5 819.3 896.8 932.6 977.7 15061.2 15219.8 15307.7 15412.4 15654.4 858.6 868.6 870.7 878.0 889.0 8485.1 8740.3 8761.9 8762.9 8860.4 489493.0 509584.0 521828.0 528542.0 540978.0 67671.0 70073.0 71029.0 71114.6 71514.6 1065.4 1077.1 1080.8 1103.1 1108.9 14269.4 14357.6 14400.0 14485.7 14519.6 29772.0 30045.0 30499.8 31070.8 31850.0 39525.2 40039.8 41810.6 42918.8 44623.1 8497.7 8677.9 8817.6 8845.0 8911.0 10350.8 10508.3 14904.9 15379.8 16079.2 13321.5 13381.9 13398.9 13613.9 13846.9 8756.9 9397.5 9558.9 9853.9 13467.7 9495.6 9661.7 9729.1 9757.8 9835.0 14010.6 14112.9 14699.2 14725.5 14810.3 15043.9 15069.9 15277.6 15423.5 15458.8 18:43:08 INFO - 2015-12-20 18:43:08,869 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,869 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4933.32 Median:6387.79 stddev:2587.74 (40.5%) stddev-sans-first:2581.50 18:43:08 INFO - 2015-12-20 18:43:08,870 DEBUG : BROWSER_OUTPUT: Values: 1415.9 1423.8 1494.5 1660.5 1721.4 6775.9 6957.3 6966.4 7054.2 7301.1 7292.7 7324.6 7360.2 7395.5 7400.4 2028.3 2068.9 2079.6 2080.2 2082.1 2053.4 2074.6 2084.7 2127.7 2128.5 1688.5 1734.1 2029.5 2065.8 2089.6 2026.1 2030.9 2031.0 2033.0 2041.2 2034.1 2039.4 2137.9 2138.1 2139.9 7151.6 7173.9 7232.7 7236.2 7238.2 4125.3 4182.5 4199.2 4200.4 4213.5 2757.5 2791.6 2801.0 2808.1 2845.3 930.2 942.0 961.0 963.5 970.3 9472.9 9486.4 9504.9 9505.0 9522.9 3694.2 3714.8 3785.3 3794.1 3816.2 7807.1 7829.7 7838.2 7876.8 7884.8 4144.8 4152.2 4171.5 4181.7 4185.2 3778.7 3805.4 3810.4 3822.0 3839.7 3051.4 3113.2 3116.8 3138.8 3154.9 932.9 945.3 954.3 956.5 961.0 851.5 874.2 931.7 937.5 959.7 6482.9 6528.5 6546.9 6571.7 6583.5 576.7 585.1 590.7 594.5 730.9 5152.0 5209.2 5209.3 5238.5 5238.6 8025.8 8653.0 8697.7 8716.4 8719.2 8484.9 8532.8 8542.0 8577.6 8637.8 6627.3 6640.4 6670.7 6708.2 6709.2 6502.7 6505.4 6513.6 6519.8 6561.4 7429.9 7670.2 7712.5 7713.7 7731.1 7350.0 7472.3 7492.4 7552.8 7840.5 6375.5 6381.0 6420.7 6444.6 6454.1 6901.9 6941.0 6950.0 6958.9 6975.0 6350.9 6505.4 6529.1 6691.9 6781.3 5653.3 5710.3 6212.3 6259.1 6306.0 6157.2 6260.5 6282.0 6318.7 6394.6 5993.3 6009.4 6015.7 6020.5 6025.5 6025.1 6170.0 6170.3 6174.7 6187.9 18:43:08 INFO - 2015-12-20 18:43:08,870 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,871 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4867.63 Median:5583.24 stddev:1456.90 (26.1%) stddev-sans-first:1419.93 18:43:08 INFO - 2015-12-20 18:43:08,871 DEBUG : BROWSER_OUTPUT: Values: 291.8 301.4 304.1 304.5 304.9 5548.1 5569.9 5589.3 5669.6 5750.1 5577.2 5611.1 5622.1 5637.1 5640.8 4292.4 4313.0 4321.4 4332.2 4333.6 4291.4 4315.5 4318.4 4329.2 4337.1 4194.3 4236.9 4266.7 4284.2 4301.0 4276.8 4279.1 4283.3 4287.7 4298.4 3706.4 3711.9 3719.8 3732.7 3734.4 5454.5 5465.4 5466.4 5469.8 5473.1 4701.6 4933.2 4936.7 4940.8 4941.3 5688.0 5814.6 5835.3 5846.4 5854.9 3993.3 3998.6 3998.9 4002.1 4005.1 6093.2 6162.7 6163.3 6167.7 6168.0 3939.3 4087.1 4091.9 4096.2 4146.9 4193.8 4193.9 4194.4 4200.6 4205.2 4847.3 4851.9 4852.2 4855.4 4858.9 5837.2 5865.3 5874.1 5886.9 5891.2 1421.1 1465.0 1490.8 1491.6 1492.4 978.1 983.6 1000.3 1000.6 1001.6 5053.7 5064.0 5074.2 5080.0 5091.0 6022.9 6030.7 6039.7 6039.8 6053.2 5032.4 5043.1 5055.2 5083.8 5087.5 3225.2 3244.9 3282.7 3290.4 3331.6 5778.7 5779.9 5789.0 5790.6 5799.9 6339.1 6351.9 6361.8 6365.9 6366.3 5619.5 5770.1 5782.7 5791.7 5795.9 6157.3 6160.0 6172.3 6177.5 6181.3 5997.2 6000.9 6014.8 6017.0 6017.6 5766.5 5774.1 5774.9 5776.7 5790.7 4065.4 4114.4 4159.8 4164.5 4168.5 5957.6 6142.3 6151.2 6154.3 6163.1 5935.7 5943.5 5946.6 5969.2 5980.0 5905.8 5910.2 5922.1 5948.3 5952.8 5670.1 5776.5 5802.2 5807.2 5817.1 5973.8 5974.0 5988.9 5997.3 6004.4 5763.3 5831.9 5834.4 5841.4 5858.6 18:43:08 INFO - 2015-12-20 18:43:08,871 DEBUG : BROWSER_OUTPUT: 18:43:08 INFO - 2015-12-20 18:43:08,871 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11838.11 Median:52653.84 stddev:13728.00 (26.1%) stddev-sans-first:13740.92 18:43:08 INFO - 2015-12-20 18:43:08,871 DEBUG : BROWSER_OUTPUT: Values: 675.4 739.5 776.8 781.6 789.0 10272.3 10654.3 10670.7 10686.9 10702.4 11183.0 11245.8 11275.3 11315.9 11321.2 622.0 630.2 785.4 793.5 796.1 797.6 808.6 810.8 815.0 815.8 835.3 839.2 841.7 843.3 844.3 832.2 833.9 834.2 834.6 835.3 621.2 622.7 622.8 622.8 623.3 11262.8 11391.9 11408.0 11424.8 11445.8 10247.3 10767.1 10824.7 10932.5 11048.6 8711.8 8741.2 8764.3 8784.6 8842.7 3260.2 3297.3 3314.3 3323.8 3327.3 38146.0 38312.0 38565.0 38580.8 40212.6 8511.7 8554.7 8741.1 8768.6 8811.3 14746.9 14756.1 14764.0 14765.2 14782.8 6105.8 6266.7 6294.5 6332.8 6371.3 3233.3 3255.8 3485.6 3558.6 3613.6 2609.6 2612.2 2636.1 2639.3 2650.0 463.6 466.3 466.8 468.3 473.8 551.6 555.7 562.9 564.8 579.1 6922.7 7049.2 7524.5 7603.6 7726.3 522.6 569.9 572.2 573.5 578.5 3283.0 3542.2 3568.7 3627.7 3673.6 48582.8 52470.2 52570.7 52641.2 52666.5 42435.2 42611.0 42778.8 43440.0 44678.1 35575.5 35960.6 40651.4 40663.8 40745.8 7429.7 7608.7 8159.6 8285.3 8294.5 30481.5 30653.2 30769.4 31716.0 31773.4 37937.1 38114.2 38695.0 41553.4 42006.4 9147.6 9188.8 9210.3 9479.0 9557.6 10923.5 11015.2 11073.6 11075.0 11615.1 9664.7 9854.9 9903.8 10151.3 10167.0 9628.8 10140.2 10366.5 10439.7 10457.8 7987.0 8740.4 9912.3 9916.4 9998.9 8144.3 8176.7 8363.2 8489.1 8629.1 7354.9 7574.7 7721.5 7925.2 8369.2 18:43:08 INFO - 2015-12-20 18:43:08,871 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:43:08 INFO - 2015-12-20 18:43:08,871 DEBUG : BROWSER_OUTPUT: 18:43:09 INFO - 2015-12-20 18:43:09,562 INFO : Browser exited with error code: 0 18:43:09 INFO - 2015-12-20 18:43:09,580 INFO : Completed test dromaeo_css (00:18:35) 18:43:09 INFO - 2015-12-20 18:43:09,580 INFO : Starting test kraken 18:43:09 INFO - 2015-12-20 18:43:09,581 DEBUG : operating with platform_type : linux_ 18:43:09 INFO - 2015-12-20 18:43:09,581 INFO : Initialising browser for kraken test... 18:43:09 INFO - 2015-12-20 18:43:09,587 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk_Z8BW/profile http://localhost:41155/getInfo.html 18:43:13 INFO - 2015-12-20 18:43:13,028 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 18:43:13 INFO - 2015-12-20 18:43:13,694 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:43:13 INFO - 2015-12-20 18:43:13,694 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:43:13 INFO - 2015-12-20 18:43:13,694 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:43:13 INFO - 2015-12-20 18:43:13,694 DEBUG : BROWSER_OUTPUT: __metrics 18:43:13 INFO - 2015-12-20 18:43:13,798 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:43:14 INFO - 2015-12-20 18:43:14,678 INFO : Browser initialized. 18:43:14 INFO - 2015-12-20 18:43:14,678 INFO : Running cycle 1/1 for kraken test... 18:43:14 INFO - 2015-12-20 18:43:14,679 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk_Z8BW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:43:26 INFO - 2015-12-20 18:43:26,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 151052288 18:43:26 INFO - 2015-12-20 18:43:26,661 DEBUG : BROWSER_OUTPUT: 18:43:29 INFO - 2015-12-20 18:43:29,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41155/tests/kraken/driver.html?testName=audio-beat-detection) 18:43:29 INFO - 2015-12-20 18:43:29,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 151801856 18:43:29 INFO - 2015-12-20 18:43:29,879 DEBUG : BROWSER_OUTPUT: 18:43:32 INFO - 2015-12-20 18:43:32,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41155/tests/kraken/driver.html?testName=audio-dft) 18:43:33 INFO - 2015-12-20 18:43:33,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 150630400 18:43:33 INFO - 2015-12-20 18:43:33,219 DEBUG : BROWSER_OUTPUT: 18:43:36 INFO - 2015-12-20 18:43:36,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41155/tests/kraken/driver.html?testName=audio-fft) 18:43:36 INFO - 2015-12-20 18:43:36,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 146063360 18:43:36 INFO - 2015-12-20 18:43:36,706 DEBUG : BROWSER_OUTPUT: 18:43:38 INFO - 2015-12-20 18:43:38,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41155/tests/kraken/driver.html?testName=audio-oscillator) 18:43:39 INFO - 2015-12-20 18:43:39,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 147263488 18:43:39 INFO - 2015-12-20 18:43:39,393 DEBUG : BROWSER_OUTPUT: 18:43:41 INFO - 2015-12-20 18:43:41,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41155/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:43:42 INFO - 2015-12-20 18:43:42,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 146710528 18:43:42 INFO - 2015-12-20 18:43:42,249 DEBUG : BROWSER_OUTPUT: 18:43:45 INFO - 2015-12-20 18:43:45,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41155/tests/kraken/driver.html?testName=imaging-darkroom) 18:43:45 INFO - 2015-12-20 18:43:45,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 147480576 18:43:45 INFO - 2015-12-20 18:43:45,873 DEBUG : BROWSER_OUTPUT: 18:43:49 INFO - 2015-12-20 18:43:49,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41155/tests/kraken/driver.html?testName=imaging-desaturate) 18:43:50 INFO - 2015-12-20 18:43:50,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 146952192 18:43:50 INFO - 2015-12-20 18:43:50,016 DEBUG : BROWSER_OUTPUT: 18:43:52 INFO - 2015-12-20 18:43:52,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41155/tests/kraken/driver.html?testName=json-parse-financial) 18:43:53 INFO - 2015-12-20 18:43:53,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 147615744 18:43:53 INFO - 2015-12-20 18:43:53,581 DEBUG : BROWSER_OUTPUT: 18:43:55 INFO - 2015-12-20 18:43:55,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41155/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:43:55 INFO - 2015-12-20 18:43:55,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 148451328 18:43:55 INFO - 2015-12-20 18:43:55,944 DEBUG : BROWSER_OUTPUT: 18:43:57 INFO - 2015-12-20 18:43:57,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:43:58 INFO - 2015-12-20 18:43:58,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 148774912 18:43:58 INFO - 2015-12-20 18:43:58,454 DEBUG : BROWSER_OUTPUT: 18:44:00 INFO - 2015-12-20 18:44:00,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:44:01 INFO - 2015-12-20 18:44:01,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 149176320 18:44:01 INFO - 2015-12-20 18:44:01,524 DEBUG : BROWSER_OUTPUT: 18:44:04 INFO - 2015-12-20 18:44:04,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:44:04 INFO - 2015-12-20 18:44:04,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 149204992 18:44:04 INFO - 2015-12-20 18:44:04,671 DEBUG : BROWSER_OUTPUT: 18:44:07 INFO - 2015-12-20 18:44:07,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:44:07 INFO - 2015-12-20 18:44:07,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 148676608 18:44:07 INFO - 2015-12-20 18:44:07,825 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41155/tests/kraken/driver.html?testName=ai-astar) 18:44:09 INFO - 2015-12-20 18:44:09,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 149229568 18:44:09 INFO - 2015-12-20 18:44:09,858 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,858 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:44:09 INFO - 2015-12-20 18:44:09,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:44:09 INFO - 2015-12-20 18:44:09,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:44:09 INFO - 2015-12-20 18:44:09,858 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:44:09 INFO - 2015-12-20 18:44:09,859 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;108;112;112;113;123;112;111;112;113 18:44:09 INFO - 2015-12-20 18:44:09,859 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;155;166;132;164;155;139;167;134 18:44:09 INFO - 2015-12-20 18:44:09,859 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;165;161;163;163;170;161;164;164 18:44:09 INFO - 2015-12-20 18:44:09,859 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;79;72;141;73;74;74;72;90 18:44:09 INFO - 2015-12-20 18:44:09,859 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;129;95;94;94;134;97;94;128 18:44:09 INFO - 2015-12-20 18:44:09,859 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;112;110;111;111;110;109;110 18:44:09 INFO - 2015-12-20 18:44:09,859 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;150;149;148;148;149;148;147 18:44:09 INFO - 2015-12-20 18:44:09,860 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;97;95;96;96;97;96;96 18:44:09 INFO - 2015-12-20 18:44:09,860 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;73;75;73;73;76;72;74;72 18:44:09 INFO - 2015-12-20 18:44:09,860 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;67;69;68;68;69;68 18:44:09 INFO - 2015-12-20 18:44:09,860 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;86;84;85;84;91;84;87;85 18:44:09 INFO - 2015-12-20 18:44:09,860 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;119;122;126;123;119;129;118;122;126 18:44:09 INFO - 2015-12-20 18:44:09,860 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;144;145;142;144;133;142;143;149;138 18:44:09 INFO - 2015-12-20 18:44:09,860 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;82;67;71;68;72;69;70;69;71;70 18:44:09 INFO - 2015-12-20 18:44:09,860 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:44:09 INFO - 2015-12-20 18:44:09,861 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:44:09 INFO - 2015-12-20 18:44:09,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,782 18:44:09 INFO - 2015-12-20 18:44:09,861 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:44:09 INFO - 2015-12-20 18:44:09,861 DEBUG : BROWSER_OUTPUT: __startTimestamp1450665849852__endTimestamp 18:44:09 INFO - 2015-12-20 18:44:09,861 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,862 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:44:09 INFO - 2015-12-20 18:44:09,862 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:3.85 (3.4%) stddev-sans-first:4.08 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: Values: 112.0 108.0 112.0 112.0 113.0 123.0 112.0 111.0 112.0 113.0 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:155.00 stddev:14.55 (9.4%) stddev-sans-first:15.35 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 155.0 166.0 132.0 164.0 155.0 139.0 167.0 134.0 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.59 (1.6%) stddev-sans-first:2.68 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 165.0 161.0 163.0 163.0 170.0 161.0 164.0 164.0 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:73.50 stddev:21.56 (29.3%) stddev-sans-first:22.57 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 79.0 72.0 141.0 73.0 74.0 74.0 72.0 90.0 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:94.00 stddev:17.30 (18.4%) stddev-sans-first:17.93 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 129.0 95.0 94.0 94.0 134.0 97.0 94.0 128.0 18:44:09 INFO - 2015-12-20 18:44:09,863 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 112.0 110.0 111.0 111.0 110.0 109.0 110.0 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 150.0 149.0 148.0 148.0 149.0 148.0 147.0 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 97.0 95.0 96.0 96.0 97.0 96.0 96.0 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,864 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.20 Median:73.00 stddev:1.40 (1.9%) stddev-sans-first:1.41 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 75.0 73.0 73.0 76.0 72.0 74.0 72.0 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 67.0 69.0 68.0 68.0 69.0 68.0 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.44 (2.9%) stddev-sans-first:2.30 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 86.0 84.0 85.0 84.0 91.0 84.0 87.0 85.0 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:124.50 stddev:4.06 (3.3%) stddev-sans-first:3.74 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: Values: 129.0 119.0 122.0 126.0 123.0 119.0 129.0 118.0 122.0 126.0 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:143.50 stddev:5.35 (3.7%) stddev-sans-first:4.52 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: Values: 132.0 144.0 145.0 142.0 144.0 133.0 142.0 143.0 149.0 138.0 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: 18:44:09 INFO - 2015-12-20 18:44:09,865 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.50 stddev:4.18 (5.9%) stddev-sans-first:1.58 18:44:09 INFO - 2015-12-20 18:44:09,866 DEBUG : BROWSER_OUTPUT: Values: 82.0 67.0 71.0 68.0 72.0 69.0 70.0 69.0 71.0 70.0 18:44:09 INFO - 2015-12-20 18:44:09,866 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:44:09 INFO - 2015-12-20 18:44:09,866 DEBUG : BROWSER_OUTPUT: 18:44:10 INFO - 2015-12-20 18:44:10,730 INFO : Browser exited with error code: 0 18:44:10 INFO - 2015-12-20 18:44:10,776 INFO : Completed test kraken (00:01:01) 18:44:10 INFO - 2015-12-20 18:44:10,776 INFO : Starting test v8_7 18:44:10 INFO - 2015-12-20 18:44:10,776 DEBUG : operating with platform_type : linux_ 18:44:10 INFO - 2015-12-20 18:44:10,776 INFO : Initialising browser for v8_7 test... 18:44:10 INFO - 2015-12-20 18:44:10,782 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuFCaHm/profile http://localhost:41155/getInfo.html 18:44:14 INFO - 2015-12-20 18:44:14,074 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 18:44:14 INFO - 2015-12-20 18:44:14,723 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:44:14 INFO - 2015-12-20 18:44:14,723 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:44:14 INFO - 2015-12-20 18:44:14,723 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:44:14 INFO - 2015-12-20 18:44:14,723 DEBUG : BROWSER_OUTPUT: __metrics 18:44:14 INFO - 2015-12-20 18:44:14,848 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:44:15 INFO - 2015-12-20 18:44:15,694 INFO : Browser initialized. 18:44:15 INFO - 2015-12-20 18:44:15,694 INFO : Running cycle 1/1 for v8_7 test... 18:44:15 INFO - 2015-12-20 18:44:15,695 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuFCaHm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:44:27 INFO - 2015-12-20 18:44:27,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 150884352 18:44:27 INFO - 2015-12-20 18:44:27,616 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41155/tests/v8_7/run.html (next: http://localhost:41155/tests/v8_7/run.html) 18:44:49 INFO - 2015-12-20 18:44:49,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 145354752 18:44:49 INFO - 2015-12-20 18:44:49,328 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,328 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:44:49 INFO - 2015-12-20 18:44:49,328 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:44:49 INFO - 2015-12-20 18:44:49,328 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:44:49 INFO - 2015-12-20 18:44:49,328 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:44:49 INFO - 2015-12-20 18:44:49,328 DEBUG : BROWSER_OUTPUT: |0;Richards;164.63615409944023 18:44:49 INFO - 2015-12-20 18:44:49,329 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.5341888527102 18:44:49 INFO - 2015-12-20 18:44:49,329 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.3476310625175 18:44:49 INFO - 2015-12-20 18:44:49,329 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 18:44:49 INFO - 2015-12-20 18:44:49,329 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1094.0919037199126 18:44:49 INFO - 2015-12-20 18:44:49,329 DEBUG : BROWSER_OUTPUT: |5;Earley;694.9270326615705 18:44:49 INFO - 2015-12-20 18:44:49,329 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 18:44:49 INFO - 2015-12-20 18:44:49,329 DEBUG : BROWSER_OUTPUT: |7;RegExp;26578.947368421053 18:44:49 INFO - 2015-12-20 18:44:49,329 DEBUG : BROWSER_OUTPUT: |8;Splay;594.5303210463734 18:44:49 INFO - 2015-12-20 18:44:49,330 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 18:44:49 INFO - 2015-12-20 18:44:49,330 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:44:49 INFO - 2015-12-20 18:44:49,330 DEBUG : BROWSER_OUTPUT: __startTimestamp1450665889320__endTimestamp 18:44:49 INFO - 2015-12-20 18:44:49,330 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,330 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:44:49 INFO - 2015-12-20 18:44:49,330 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:44:49 INFO - 2015-12-20 18:44:49,330 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,331 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.64 Median:164.64 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,331 DEBUG : BROWSER_OUTPUT: Values: 164.6 18:44:49 INFO - 2015-12-20 18:44:49,331 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,331 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.53 Median:191.53 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,331 DEBUG : BROWSER_OUTPUT: Values: 191.5 18:44:49 INFO - 2015-12-20 18:44:49,331 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,331 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,331 DEBUG : BROWSER_OUTPUT: Values: 280.3 18:44:49 INFO - 2015-12-20 18:44:49,332 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,332 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,332 DEBUG : BROWSER_OUTPUT: Values: 5202.1 18:44:49 INFO - 2015-12-20 18:44:49,332 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,332 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1094.09 Median:1094.09 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,332 DEBUG : BROWSER_OUTPUT: Values: 1094.1 18:44:49 INFO - 2015-12-20 18:44:49,332 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,333 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:694.93 Median:694.93 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,333 DEBUG : BROWSER_OUTPUT: Values: 694.9 18:44:49 INFO - 2015-12-20 18:44:49,333 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,333 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,333 DEBUG : BROWSER_OUTPUT: Values: 12207.3 18:44:49 INFO - 2015-12-20 18:44:49,333 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,333 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26578.95 Median:26578.95 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,334 DEBUG : BROWSER_OUTPUT: Values: 26578.9 18:44:49 INFO - 2015-12-20 18:44:49,334 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,334 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.53 Median:594.53 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,334 DEBUG : BROWSER_OUTPUT: Values: 594.5 18:44:49 INFO - 2015-12-20 18:44:49,334 DEBUG : BROWSER_OUTPUT: 18:44:49 INFO - 2015-12-20 18:44:49,334 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 18:44:49 INFO - 2015-12-20 18:44:49,335 DEBUG : BROWSER_OUTPUT: Values: 4840.6 18:44:49 INFO - 2015-12-20 18:44:49,335 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:44:49 INFO - 2015-12-20 18:44:49,335 DEBUG : BROWSER_OUTPUT: 18:44:50 INFO - 2015-12-20 18:44:50,202 INFO : Browser exited with error code: 0 18:44:50 INFO - 2015-12-20 18:44:50,219 INFO : Completed test v8_7 (00:00:39) 18:44:50 INFO - 2015-12-20 18:44:50,319 INFO : Completed test suite (00:20:15) 18:44:50 INFO - 2015-12-20 18:44:50,319 DEBUG : Working with test: dromaeo_css 18:44:50 INFO - 2015-12-20 18:44:50,319 DEBUG : Generating results file: dromaeo_css 18:44:50 INFO - 2015-12-20 18:44:50,320 DEBUG : Working with test: kraken 18:44:50 INFO - 2015-12-20 18:44:50,321 DEBUG : Generating results file: kraken 18:44:50 INFO - 2015-12-20 18:44:50,321 INFO : javascript benchmark 18:44:50 INFO - 2015-12-20 18:44:50,321 DEBUG : Working with test: v8_7 18:44:50 INFO - 2015-12-20 18:44:50,321 DEBUG : Generating results file: v8_7 18:44:50 INFO - 2015-12-20 18:44:50,321 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:44:50 INFO - 2015-12-20 18:44:50,479 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 18:44:50 INFO - 2015-12-20 18:44:50,480 DEBUG : process_Request line: dromaeo_css 6367.31 graph.html#tests=[[72,132,43]] 18:44:50 INFO - 2015-12-20 18:44:50,480 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:44:50 INFO - 2015-12-20 18:44:50,524 DEBUG : process_Request line: kraken 1529.90 graph.html#tests=[[232,132,43]] 18:44:50 INFO - 2015-12-20 18:44:50,524 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:44:50 INFO - 2015-12-20 18:44:50,555 DEBUG : process_Request line: v8_7 21287.58 graph.html#tests=[[230,132,43]] 18:44:50 INFO - 2015-12-20 18:44:50,557 INFO : javascript benchmark 18:44:50 INFO - 2015-12-20 18:44:50,561 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2618.2145356393085, 2645.5370310195713, 2687.0, 2687.6102965070054, 2708.485387776323, 4413.0, 4592.4718657354415, 4645.18709225885, 4651.511591282909, 4665.813367465302, 4509.075639493904, 4522.14079324928, 4584.816607335702, 4677.883052923678, 4701.388819453467, 4229.661627069835, 4275.508316543591, 4298.742075475481, 4315.848945286915, 4359.520452750211, 4221.514525829522, 4301.5698430157045, 4310.80601372939, 4338.262495375794, 4406.405135306724, 4095.28332541804, 4146.66826653867, 4185.0, 4291.699581029329, 4311.396404503372, 4285.078708077778, 4308.655307575386, 4308.719933204332, 4316.223079845627, 4329.7618630975285, 4266.491956898328, 4272.508661503935, 4274.380214868826, 4279.422277992462, 4339.457567804025, 4319.114581510814, 4456.309272062803, 4526.932096018562, 4614.630829533629, 4615.076984603093, 4964.478729733398, 4992.301077849104, 4997.525235102659, 5013.9972005598665, 5035.571976382012, 4970.701757894538, 4997.0505603935135, 5024.648274620778, 5027.472115427864, 5034.0686972910125, 4417.403650507173, 4512.706674066175, 4624.445066591963, 4675.883102922454, 4748.287756836433, 5023.0, 5040.581375021793, 5048.419431765394, 5086.4659210783075, 5087.8982420351385, 4661.394018777537, 4907.092187945242, 4914.140025495524, 4930.457649658535, 4963.60291176705, 4844.467108618049, 4894.388201474816, 4932.926006109911, 4946.258061290763, 4986.8753281168265, 4902.607791376681, 4903.803847846046, 4912.0, 4922.040202160616, 4970.925436118461, 4641.628669706415, 4821.132196204647, 4825.179719447702, 4908.042931628298, 4929.06347793918, 4058.898527536835, 4101.282275601758, 4112.383142528644, 4115.32097203964, 4133.627973482341, 3651.2149887773726, 3653.2510835278704, 3658.5426821647293, 3673.2653469306247, 3693.150575367627, 4101.979490102531, 4194.2869712148395, 4215.241256573846, 4301.870943871689, 4318.913621727548, 4945.67853089548, 4949.010197960422, 4951.752412379366, 4958.132326842788, 4975.427825800007, 4261.126469073833, 4267.637250833652, 4274.252005899018, 4289.592488713567, 4310.956890431118, 4174.624283814472, 4259.105587826592, 4342.848000320037, 4346.673999450054, 4430.933535996963, 4692.272697731857, 4732.881677958078, 4739.289106633894, 4744.027474367746, 4754.358161648133, 4973.45292017885, 5012.799488020439, 5016.54851063406, 5032.823851165192, 5056.191009438619, 4445.488768791631, 4543.386642803312, 4673.415823022122, 4795.424549054136, 4816.8554943351755, 4891.388576427947, 4915.1644220481885, 4926.236433352836, 4946.901061978812, 4978.477259887804, 4709.7174169549935, 4986.650934434555, 4998.175301075282, 4998.3252260945765, 5039.395272567315, 4740.905181896412, 4748.192807222711, 4811.687240329367, 4823.855284341475, 4853.199222128309, 4754.809807607657, 4798.376211092535, 4804.615630749601, 4838.927416088832, 4875.293082503088, 4511.887202819956, 4659.464161621457, 4700.788464519173, 4726.19654658702, 4791.496892826342, 4716.103940251342, 4754.690945088558, 4762.9285560715925, 4795.640326975421, 4829.782659780389, 4768.928466073081, 4794.376731025084, 4795.496472870298, 4819.012102519046, 4832.371791667061], "unit": "score", "name": "dojo.html", "value": 4537.056582721748}, {"lowerIsBetter": false, "replicates": [544.5875149314797, 550.6420826462796, 566.0546886699212, 579.4784693775603, 588.299923091521, 31542.0, 31885.202869928264, 31927.201819954513, 32060.83969580152, 32126.35747285053, 36874.631253687454, 37627.43558846613, 37658.246835063284, 37753.244935101284, 37774.24451510968, 7875.80310492238, 8009.9587053683235, 8017.95991020044, 8027.197280271985, 8058.153893841121, 7758.961205193966, 7832.490888092284, 7841.960790196041, 7873.173316801739, 7896.565688887109, 7840.255175758294, 7902.170272121431, 7988.520688758664, 7993.880091798627, 8000.359971202319, 7881.251281128284, 7887.408444366638, 7901.525908445512, 7971.720989765359, 8008.959955200245, 7789.143194248685, 7926.524408535506, 7932.2067793220795, 7933.761987140395, 7992.880106798345, 36852.262954740756, 37338.06654833624, 37370.06574835624, 37410.0, 37412.25175496502, 2879.2226098953374, 3120.422721796475, 3332.800191930903, 3748.5689145748315, 3786.2616789726017, 27013.0, 27216.31959201016, 27488.58767118495, 27610.0, 27892.302692432648, 3271.8854840080485, 3484.216051388443, 3494.109002204422, 3539.8407071681836, 3563.3051554946796, 199216.0, 200396.0, 201323.0, 201381.0, 202600.0, 52191.47808521866, 55573.0, 55658.0, 56092.07355485159, 56193.71903140458, 44769.32846007313, 67723.3227667717, 68434.3156568428, 69457.65271173611, 69590.65204673944, 13037.348132593332, 13046.086773925734, 13068.803967940488, 13069.607911762663, 13264.933675331562, 10555.31390459633, 10651.73370665724, 10659.626913058006, 10684.626038088629, 10761.408122553335, 19405.4178374649, 19736.605267894563, 19959.800401996086, 19992.50018749543, 19996.20015199376, 7676.11724651661, 7957.965464489579, 7972.0, 8049.0, 8088.272055515032, 864.6109250837148, 865.2126564825978, 893.8569828827357, 1009.9192064634811, 1070.9089727373105, 25928.61107083395, 29008.709912900602, 29636.259093522403, 30333.0, 30808.537871931938, 934.1359242700611, 967.3760424526141, 997.396575072071, 1036.5905467340358, 1083.160550573312, 12808.551700690432, 12852.678683032998, 12857.678558036125, 12895.548655797002, 12962.416691248727, 304813.0, 311277.0, 312214.0, 312388.0, 313930.0, 46001.76999114983, 46672.299915501295, 46765.53234467612, 46848.29727554089, 46889.53110468852, 1230.7476967221878, 1248.444442223202, 1249.6001279590625, 1253.9623811285676, 1266.3478308671042, 23742.099994521282, 24193.27420177327, 24201.878990604935, 24458.75541244636, 24486.26541203767, 37029.44455833219, 37292.44061339028, 37387.813060934524, 37659.24681506409, 37664.62335376611, 244775.0, 246490.0, 247321.0, 247647.0, 247760.0, 29647.0, 42483.0, 42638.10732740997, 43629.0, 43632.12735745331, 36343.81828090949, 36780.44829327509, 37200.62799371972, 37308.440373393874, 37349.066273343386, 31531.84234078815, 36811.447828282064, 38262.2347553053, 38463.230735384575, 38645.420318694676, 31997.84001080073, 32432.513512297806, 32461.35077298488, 32582.34835303328, 37110.62889371072, 32310.0, 32659.510107347935, 32860.83569582232, 32946.17634559155, 33016.33967320592, 28702.0, 29366.559501607066, 29460.263493412836, 29513.852430738567, 29695.109146725634, 23636.29091127269, 23709.644355334338, 23731.455896387204, 24009.279721608378, 24059.639105413084], "unit": "score", "name": "ext.html", "value": 17090.64181923062}, {"lowerIsBetter": false, "replicates": [314.60674157303373, 317.5284702217207, 320.19151642103685, 324.33511301831226, 325.38339845991845, 12191.817122743167, 12536.122471427003, 15689.686206275868, 16200.108994005324, 16283.185840707962, 11722.472488738005, 11731.29612223265, 11857.347845868473, 14029.78955315671, 14624.926875365634, 4705.505921878204, 4778.569928706424, 4952.628552858532, 4988.975055124719, 5812.82561523155, 5694.060480020791, 6049.334573196967, 6228.0, 6242.87514249717, 6247.937520624781, 6053.334133245339, 6223.937760622381, 6517.543771935966, 6553.803385898431, 6565.244996825355, 6437.742490300382, 6452.064450654629, 6487.351264873522, 6489.61062336259, 6519.087327774116, 5891.851089037639, 6091.208142941434, 6094.268687757453, 6096.451319381277, 6100.115483254947, 15476.690466190727, 16817.83182168175, 19285.710714339297, 20352.18591256348, 20363.0, 1915.205189846212, 1932.1305412564402, 1955.9217631294732, 1997.450910104754, 2006.26771228502, 13730.45078196871, 13734.862651373458, 13865.09876858001, 13982.720345593132, 14270.928645356811, 1906.27561526619, 1910.8566857485605, 1912.407153782332, 1931.2564662604857, 1945.5525229197365, 57268.713656431864, 62578.37421625771, 62863.0, 63822.36177638257, 64227.357726422604, 14768.63078423048, 15277.312520936584, 15285.38858445672, 15291.923540382228, 15331.92334038345, 23028.65457018146, 23157.073717051127, 23162.8841855793, 23437.7656223439, 23453.296401107993, 8463.788405289793, 8549.829003419896, 8558.700445484377, 8608.354373421893, 8638.956805215934, 6966.616836073963, 6971.163460384685, 6988.720451181997, 6999.440044796404, 7017.0, 4034.5561988181275, 4177.97911010443, 4218.6414154797185, 7443.8883416748795, 7522.736704215436, 1726.5856194513226, 1735.670222657691, 1751.6496700659918, 1755.2013833705632, 1804.2061492943062, 809.4576633655465, 819.2831272636444, 896.7668406214301, 932.5896605493562, 977.7213494154132, 15061.171635559931, 15219.847801521842, 15307.693846123015, 15412.383504659689, 15654.373825047098, 858.6090533336036, 868.5830801215452, 870.6822009966444, 877.9868301975475, 888.9911100889037, 8485.109063548362, 8740.344474164463, 8761.948566172101, 8762.912370876336, 8860.424072435271, 489493.0, 509584.0, 521828.0, 528542.0, 540978.0, 67671.0, 70073.0, 71029.0, 71114.64442677857, 71514.64242678753, 1065.3554599467366, 1077.1167642533205, 1080.8270676691534, 1103.0844399148848, 1108.9168312376603, 14269.363972828769, 14357.641058973191, 14400.0, 14485.710285794436, 14519.637009074857, 29772.0, 30045.0, 30499.84750076324, 31070.844645776626, 31850.0, 39525.2094958105, 40039.79980100081, 41810.58189418067, 42918.78540607277, 44623.10753784841, 8497.74506764798, 8677.913220867964, 8817.603207855534, 8845.0, 8911.0, 10350.809656889554, 10508.264421490423, 14904.85095149078, 15379.76930346068, 16079.196040198178, 13321.467141314239, 13381.933090334485, 13398.9330053353, 13613.86386136126, 13846.861531384557, 8756.868646970173, 9397.483138427453, 9558.856617150888, 9853.901460985586, 13467.663308417368, 9495.572699228413, 9661.661841835503, 9729.124378805942, 9757.756056098371, 9834.950825245827, 14010.649733756738, 14112.858871411154, 14699.191544465157, 14725.484608038667, 14810.333534990736, 15043.924780376028, 15069.924650376677, 15277.576460356859, 15423.537293881202, 15458.768118478456], "unit": "score", "name": "jquery.html", "value": 8896.73305695463}, {"lowerIsBetter": false, "replicates": [1415.9433622655088, 1423.7935499352593, 1494.4993427201887, 1660.5350501859477, 1721.4491362763918, 6775.898361524581, 6957.304269573046, 6966.442684585228, 7054.1535015798045, 7301.08736407949, 7292.7447539336135, 7324.63376831159, 7360.227176146508, 7395.482316237865, 7400.407967362611, 2028.3306508852081, 2068.8655237409594, 2079.563291708743, 2080.167932826866, 2082.1255072869358, 2053.425040988526, 2074.6058248932654, 2084.7498300203997, 2127.6595744680776, 2128.4998025464, 1688.4681325382464, 1734.0549400576654, 2029.4824819670964, 2065.803748643884, 2089.582083583289, 2026.1186383922966, 2030.8679935804125, 2030.979690203094, 2033.0241484087574, 2041.2345370485918, 2034.08466190215, 2039.3983774786473, 2137.8931053447263, 2138.101997161196, 2139.8609090409227, 7151.642417879085, 7173.89239161413, 7232.74685386009, 7236.167840698282, 7238.203797582261, 4125.257453658341, 4182.477190351206, 4199.2441360555085, 4200.411942328076, 4213.53651098382, 2757.462294852505, 2791.637087178674, 2800.9859950700115, 2808.129479861229, 2845.2744550139582, 930.2325581395309, 941.9967734362882, 961.0437614573474, 963.5326866469757, 970.2965350121176, 9472.90527094727, 9486.383385079947, 9504.90495095054, 9504.954455009944, 9522.90477095234, 3694.2057457646733, 3714.832832522543, 3785.299719551892, 3794.127350709297, 3816.160444702161, 7807.141214466405, 7829.7259595913865, 7838.176991415933, 7876.763697089096, 7884.84230315402, 4144.834206631761, 4152.190322887008, 4171.541130475645, 4181.707280490336, 4185.183889141588, 3778.678812300985, 3805.3911374179997, 3810.371288737327, 3822.0, 3839.6928245740273, 3051.3744682340066, 3113.159446949356, 3116.750659947199, 3138.8116712997294, 3154.9053528394184, 932.8693982842408, 945.2910317262053, 954.2938225713061, 956.5360800012128, 961.0, 851.5103815306223, 874.2394117118021, 931.65063101337, 937.5499760115183, 959.7264779537799, 6482.870342593122, 6528.543001989815, 6546.9017964730565, 6571.67141642916, 6583.506237032242, 576.7260551238128, 585.096026638844, 590.6633219065178, 594.4946795224025, 730.9305615966475, 5151.974240128776, 5209.166533354721, 5209.270702101709, 5238.5023422774775, 5238.580913526908, 8025.8394832104195, 8652.956735216283, 8697.739067827975, 8716.43343182691, 8719.171678690514, 8484.854544636395, 8532.786680333042, 8542.0, 8577.571121443903, 8637.784055398539, 6627.304133065959, 6640.369164929324, 6670.733170673216, 6708.228553716288, 6709.19489661234, 6502.739890404331, 6505.381988711065, 6513.576617519846, 6519.8044058678315, 6561.442277406283, 7429.925700742923, 7670.194629564038, 7712.537247765152, 7713.652885620273, 7731.072271327476, 7350.0, 7472.29013243741, 7492.438067144877, 7552.8489430212185, 7840.451168418156, 6375.458086062737, 6381.0, 6420.711068001858, 6444.581102228341, 6454.064160696579, 6901.896471553031, 6940.9652951734915, 6949.965250173716, 6958.851789454886, 6974.965125174342, 6350.936490635035, 6505.447037001908, 6529.053287273414, 6691.866162676816, 6781.321867813179, 5653.265075540154, 5710.2862142232225, 6212.285587157535, 6259.12372267892, 6305.96847015762, 6157.199564056644, 6260.499160067275, 6282.026285925689, 6318.715657795502, 6394.584352017104, 5993.280806303272, 6009.399060093956, 6015.6691381974415, 6020.488258498077, 6025.487833534024, 6025.096235564701, 6170.043643235305, 6170.3212646607935, 6174.722137503733, 6187.938120618736], "unit": "score", "name": "mootools.html", "value": 3990.2989583790936}, {"lowerIsBetter": false, "replicates": [291.82782158526464, 301.434809731753, 304.1059285700043, 304.5219006160329, 304.8841440252704, 5548.056830338842, 5569.860753481165, 5589.323203039093, 5669.631473954195, 5750.108733146359, 5577.163425486179, 5611.102223644218, 5622.072358060915, 5637.069883469223, 5640.802571909973, 4292.441982542273, 4313.029568347129, 4321.416608757809, 4332.176886391591, 4333.631641310492, 4291.442112525383, 4315.4605674290715, 4318.417013703157, 4329.242382583036, 4337.1325734853, 4194.2869712149, 4236.894077648068, 4266.722663026909, 4284.157812140778, 4300.956990430102, 4276.828926842923, 4279.1227798301425, 4283.250431174532, 4287.742735435852, 4298.4197133387215, 3706.4440333949856, 3711.9443208351895, 3719.814009299524, 3732.6640602345647, 3734.402495600718, 5454.53636440903, 5465.371482279549, 5466.371367292772, 5469.753861076261, 5473.124300112003, 4701.64737644678, 4933.161362568372, 4936.728479933602, 4940.752962351868, 4941.308216849644, 5688.0, 5814.563907706939, 5835.299764028344, 5846.444587764198, 5854.853628659318, 3993.341098718708, 3998.640122388999, 3998.9200215995807, 4002.0595160137345, 4005.118873847749, 6093.2078829751845, 6162.722677479479, 6163.322034576193, 6167.735614199123, 6167.999999999955, 3939.2909276330533, 4087.080406908422, 4091.895188299143, 4096.180763847183, 4146.854860079883, 4193.790310484464, 4193.874183774492, 4194.412782210493, 4200.6219440250525, 4205.222033923673, 4847.297141914402, 4851.927221091686, 4852.223644216909, 4855.393075865517, 4858.902821943541, 5837.153612726131, 5865.266841644794, 5874.148248504029, 5886.852063847594, 5891.234139561915, 1421.1118051217989, 1465.0330781684038, 1490.754025585788, 1491.6494623763624, 1492.440334874422, 978.1441238915949, 983.6360546597662, 1000.3197825478744, 1000.6447711062614, 1001.5543083327849, 5053.747312634354, 5064.0, 5074.188129899198, 5080.0, 5091.0, 6022.879542409128, 6030.728617212236, 6039.7282122304605, 6039.8490037748525, 6053.243344581927, 5032.3961124665275, 5043.142665746832, 5055.216441451581, 5083.771230294646, 5087.516685914832, 3225.209823593235, 3244.8702051917658, 3282.7373810095614, 3290.3748287825238, 3331.5502407175204, 5778.711064446761, 5779.942200578024, 5789.0, 5790.565707571865, 5799.94200057994, 6339.11252424661, 6351.904721429182, 6361.777337793247, 6365.936340636535, 6366.331535188739, 5619.494245517923, 5770.105633626795, 5782.710864456844, 5791.652500849962, 5795.8551036224435, 6157.32269450369, 6159.96920015415, 6172.259328880384, 6177.536684748752, 6181.258249010148, 5997.220361352996, 6000.909986350121, 6014.759409623566, 6017.0, 6017.608855424383, 5766.538676905753, 5774.133879918046, 5774.884502310014, 5776.7111644418455, 5790.652560846363, 4065.430839682506, 4114.415949859266, 4159.792010399407, 4164.479440069991, 4168.499780026416, 5957.642541447527, 6142.324344322032, 6151.169592105188, 6154.323024467216, 6163.137160797402, 5935.703214839327, 5943.465088142088, 5946.583739138392, 5969.164316995711, 5980.0, 5905.763769449174, 5910.202122713378, 5922.052471604523, 5948.315943666534, 5952.791652292149, 5670.121131224501, 5776.508996735324, 5802.245708057925, 5807.186993820784, 5817.0983497557945, 5973.761049557969, 5974.044152935509, 5988.850278743066, 5997.310309314485, 6004.369541198112, 5763.250777399079, 5831.912521312099, 5834.445727655866, 5841.386654401396, 5858.648481090978], "unit": "score", "name": "prototype.html", "value": 4391.327335468831}, {"lowerIsBetter": false, "replicates": [675.4191395399956, 739.4897520710707, 776.8252143267769, 781.5818537082658, 788.9506955748855, 10272.332298400599, 10654.25420220583, 10670.733231669212, 10686.893131068688, 10702.357858528483, 11183.049440797522, 11245.83131253032, 11275.32348059115, 11315.943420282907, 11321.20751547392, 622.0141076393899, 630.2216762298558, 785.4109417936547, 793.4723408933053, 796.1123347467561, 797.5573556676043, 808.5957021489255, 810.7770363150122, 814.9714759983402, 815.7960509872532, 835.2774849754979, 839.1524560194187, 841.6969890839293, 843.3000609494105, 844.2739244249971, 832.1595188859266, 833.9416240863112, 834.2491757418311, 834.6285902773268, 835.2649668291925, 621.2141640824361, 622.6544267931297, 622.757124721359, 622.8287221014212, 623.323693792236, 11262.831057534144, 11391.943040284828, 11408.030317423028, 11424.828627570592, 11445.771084578346, 10247.333923294962, 10767.084797792197, 10824.67525974222, 10932.453377331101, 11048.613298534512, 8711.764617982377, 8741.213290803795, 8764.342674299452, 8784.560771961376, 8842.69050583233, 3260.1523603863166, 3297.3405318936307, 3314.254292784104, 3323.833808309575, 3327.2680010397676, 38146.0, 38312.04219894497, 38565.0, 38580.80709596462, 40212.59787402147, 8511.659533618586, 8554.743357699155, 8741.082186370466, 8768.561571921378, 8811.33914956368, 14746.852531474762, 14756.114633121832, 14764.040337378035, 14765.187914664797, 14782.778258325918, 6105.8168254952425, 6266.717997690115, 6294.464970477469, 6332.778352757631, 6371.331010243857, 3233.3210025894355, 3255.8372081395837, 3485.5991560970306, 3558.5551806024246, 3613.5663720353728, 2609.556375416184, 2612.2163350994624, 2636.116900838202, 2639.2741995950882, 2649.986750066237, 463.59203900567957, 466.26795930388965, 466.7666166916542, 468.32561111998615, 473.758383224558, 551.5973339462215, 555.7388027627089, 562.8874225154985, 564.8446677163813, 579.0677010013874, 6922.653867306614, 7049.224585295613, 7524.510906791041, 7603.581803000778, 7726.304632583095, 522.634156090738, 569.8657384385878, 572.2017785189637, 573.4695406748741, 578.4909279833804, 3283.0, 3542.220711443478, 3568.6966607838626, 3627.691646210049, 3673.577538583097, 48582.75708621505, 52470.21294680583, 52570.73714631402, 52641.21038184431, 52666.47333526692, 42435.1512969745, 42611.0, 42778.786106069274, 43440.0, 44678.10643787106, 35575.4663680045, 35960.64039359625, 40651.390229146586, 40663.79668101641, 40745.79627101846, 7429.665665044978, 7608.733694320672, 8159.632816523152, 8285.295749861329, 8294.502329860228, 30481.54277685792, 30653.23366915845, 30769.38461230718, 31716.0, 31773.36453270968, 37937.05157371088, 38114.237715244984, 38695.0, 41553.376699348926, 42006.36990445085, 9147.63409463614, 9188.816223675356, 9210.263178945803, 9478.95260523693, 9557.569909354235, 10923.508442120283, 11015.228933974546, 11073.612423565137, 11075.0, 11615.128865335302, 9664.661736839176, 9854.901450985399, 9903.811542614932, 10151.289409741246, 10167.0, 9628.807423851344, 10140.188784897044, 10366.502079391359, 10439.686809395731, 10457.843132353173, 7987.001624796901, 8740.431871928304, 9912.256580756328, 9916.355436896578, 9998.850017249602, 8144.30773384269, 8176.672933082848, 8363.163683631588, 8489.06620271782, 8629.13708629132, 7354.852902942018, 7574.697012119454, 7721.4594978353225, 7925.207479252029, 8369.204925532065], "unit": "score", "name": "yui.html", "value": 5512.197091599694}], "name": "dromaeo_css", "value": 6367.310881511966}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 112.0, 113.0, 123.0, 112.0, 111.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 155.0, 166.0, 132.0, 164.0, 155.0, 139.0, 167.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 165.0, 161.0, 163.0, 163.0, 170.0, 161.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 79.0, 72.0, 141.0, 73.0, 74.0, 74.0, 72.0, 90.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 129.0, 95.0, 94.0, 94.0, 134.0, 97.0, 94.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 112.0, 110.0, 111.0, 111.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 150.0, 149.0, 148.0, 148.0, 149.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 75.0, 73.0, 73.0, 76.0, 72.0, 74.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 73.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 86.0, 84.0, 85.0, 84.0, 91.0, 84.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [129.0, 119.0, 122.0, 126.0, 123.0, 119.0, 129.0, 118.0, 122.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [132.0, 144.0, 145.0, 142.0, 144.0, 133.0, 142.0, 143.0, 149.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [82.0, 67.0, 71.0, 68.0, 72.0, 69.0, 70.0, 69.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1529.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.63615409944023], "unit": "score", "name": "Richards", "value": 214.42434799999998}, {"lowerIsBetter": false, "replicates": [191.5341888527102], "unit": "score", "name": "DeltaBlue", "value": 345.2020779999999}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1094.0919037199126], "unit": "score", "name": "RayTrace", "value": 676.3499459999998}, {"lowerIsBetter": false, "replicates": [694.9270326615705], "unit": "score", "name": "Earley", "value": 959.0402569999998}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26578.947368421053], "unit": "score", "name": "RegExp", "value": 34.27468316831682}, {"lowerIsBetter": false, "replicates": [594.5303210463734], "unit": "score", "name": "Splay", "value": 137.06786199999996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21287.576974117044}]} 18:44:50 INFO - RETURN: dromaeo_css: 6367.31 18:44:50 INFO - RETURN: kraken: 1529.90 18:44:50 INFO - RETURN: v8_7: 21287.58 18:44:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21287.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1529.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6367.31"}}} 18:44:50 INFO - Return code: 0 18:44:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:44:50 INFO - # TBPL SUCCESS # 18:44:50 INFO - Running post-action listener: _resource_record_post_action 18:44:50 INFO - Running post-run listener: _resource_record_post_run 18:44:51 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 10514432; Write bytes: 467492864; Read time: 3512; Write time: 415796 18:44:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 24834048; Read time: 0; Write time: 34972 18:44:51 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8777728; Write bytes: 401694720; Read time: 3272; Write time: 370392 18:44:51 INFO - Running post-run listener: _upload_blobber_files 18:44:51 INFO - Blob upload gear active. 18:44:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:44:51 INFO - Copying logs to upload dir... 18:44:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.135469 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-20 18:44:51.404468) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 18:44:51.407814) ========= 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=edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009815 build_url: 'https://queue.taskcluster.net/v1/task/N7T_MxAaQSC1MH8YzhhpCw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-20 18:44:51.458571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:44:51.458908) ========= 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=edca6ca23558fe0608d91a4e00000196-1450645607.241408-590882845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 18:44:51.510291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 18:44:51.510818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 18:44:51.511333) ========= ========= Total master_lag: 0.25 =========