builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1450449273.73 results: success (0) buildid: 20151218054054 builduid: 4ae1c01f141c47ffbdcb4fcda5561e36 revision: 9765236f55225dd74caee557f9ee3193467d4e6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.735397) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.736211) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.736723) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006496 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.801478) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.801788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.872878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.873171) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.928183) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.928507) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.928896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:33.929203) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 06:34: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% 60.6M=0s 2015-12-18 06:34:34 (60.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:34.071904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:34.072213) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016984 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:34.130526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 06:34:34.131385) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9765236f55225dd74caee557f9ee3193467d4e6d --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 9765236f55225dd74caee557f9ee3193467d4e6d --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=2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 06:34:34,829 truncating revision to first 12 chars 2015-12-18 06:34:34,829 Setting DEBUG logging. 2015-12-18 06:34:34,829 attempt 1/10 2015-12-18 06:34:34,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9765236f5522?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 06:34:36,204 unpacking tar archive at: fx-team-9765236f5522/testing/mozharness/ program finished with exit code 0 elapsedTime=1.678284 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 06:34:35.829430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:35.829795) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:35.839447) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:35.839845) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 06:34:35.840339) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-18 06:34:35.840660) ========= /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=2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:34:36 INFO - MultiFileLogger online at 20151218 06:34:36 in /builds/slave/test 06:34:36 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 06:34:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:34:36 INFO - {'append_to_log': False, 06:34:36 INFO - 'base_work_dir': '/builds/slave/test', 06:34:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:34:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:34:36 INFO - 'branch': 'Fx-Team-Non-PGO', 06:34:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:34:36 INFO - 'config_files': ('talos/linux_config.py',), 06:34:36 INFO - 'default_actions': ('clobber', 06:34:36 INFO - 'read-buildbot-config', 06:34:36 INFO - 'download-and-extract', 06:34:36 INFO - 'populate-webroot', 06:34:36 INFO - 'create-virtualenv', 06:34:36 INFO - 'install', 06:34:36 INFO - 'run-tests'), 06:34:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:34:36 INFO - 'download_minidump_stackwalk': True, 06:34:36 INFO - 'download_symbols': 'ondemand', 06:34:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:34:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:34:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:34:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:34:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:34:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:34:36 INFO - 'installer_path': 'installer.exe', 06:34:36 INFO - 'log_level': 'info', 06:34:36 INFO - 'log_name': 'talos', 06:34:36 INFO - 'log_to_console': True, 06:34:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:34:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:34:36 INFO - 'opt_config_files': (), 06:34:36 INFO - 'pip_index': False, 06:34:36 INFO - 'sps_profile': False, 06:34:36 INFO - 'sps_profile_interval': 0, 06:34:36 INFO - 'suite': 'dromaeojs-e10s', 06:34:36 INFO - 'system_bits': '64', 06:34:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:34:36 INFO - 'title': 'talos-linux64-ix-032', 06:34:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:34:36 INFO - 'use_talos_json': True, 06:34:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:34:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:34:36 INFO - 'work_dir': 'build'} 06:34:36 INFO - ##### 06:34:36 INFO - ##### Running clobber step. 06:34:36 INFO - ##### 06:34:36 INFO - Running pre-action listener: _resource_record_pre_action 06:34:36 INFO - Running main action method: clobber 06:34:36 INFO - rmtree: /builds/slave/test/build 06:34:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:34:37 INFO - Running post-action listener: _resource_record_post_action 06:34:37 INFO - ##### 06:34:37 INFO - ##### Running read-buildbot-config step. 06:34:37 INFO - ##### 06:34:37 INFO - Running pre-action listener: _resource_record_pre_action 06:34:37 INFO - Running main action method: read_buildbot_config 06:34:37 INFO - Using buildbot properties: 06:34:37 INFO - { 06:34:37 INFO - "project": "", 06:34:37 INFO - "product": "firefox", 06:34:37 INFO - "script_repo_revision": "production", 06:34:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:34:37 INFO - "repository": "", 06:34:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:34:37 INFO - "buildid": "20151218054054", 06:34:37 INFO - "pgo_build": "False", 06:34:37 INFO - "basedir": "/builds/slave/test", 06:34:37 INFO - "buildnumber": 601, 06:34:37 INFO - "slavename": "talos-linux64-ix-032", 06:34:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:34:37 INFO - "platform": "ubuntu64_hw", 06:34:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:34:37 INFO - "branch": "fx-team", 06:34:37 INFO - "repo_path": "integration/fx-team", 06:34:37 INFO - "revision": "9765236f55225dd74caee557f9ee3193467d4e6d", 06:34:37 INFO - "stage_platform": "linux64", 06:34:37 INFO - "builduid": "4ae1c01f141c47ffbdcb4fcda5561e36", 06:34:37 INFO - "slavebuilddir": "test" 06:34:37 INFO - } 06:34:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:34:37 INFO - Running post-action listener: _resource_record_post_action 06:34:37 INFO - ##### 06:34:37 INFO - ##### Running download-and-extract step. 06:34:37 INFO - ##### 06:34:37 INFO - Running pre-action listener: _resource_record_pre_action 06:34:37 INFO - Running main action method: download_and_extract 06:34:37 INFO - mkdir: /builds/slave/test/build/tests 06:34: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')]} 06:34:37 INFO - https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:34:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/test_packages.json 06:34:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/test_packages.json 06:34:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:34:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:34:46 INFO - Downloaded 1302 bytes. 06:34:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:34:46 INFO - Using the following test package requirements: 06:34:46 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:34:46 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:34:46 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:46 INFO - u'jsshell-linux-x86_64.zip'], 06:34:46 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:34:46 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:34:46 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:34:46 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:34:46 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:34:46 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:34:46 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:34:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:34:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:46 INFO - https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:34:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:34:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:34:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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 06:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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 06:34:50 INFO - Downloaded 21870954 bytes. 06:34:50 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 06:34:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:34:50 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 06:34:51 INFO - Return code: 0 06:34:51 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 06:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:51 INFO - https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:34:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:34:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:34:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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 06:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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 06:34:55 INFO - Downloaded 21870954 bytes. 06:34:55 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 06:34:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:34:55 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 06:34:56 INFO - Return code: 0 06:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:56 INFO - https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:34:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:34:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:34:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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 06:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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 06:34:57 INFO - Downloaded 11132039 bytes. 06:34:57 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 06:34:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:34:57 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 06:34:57 INFO - Return code: 0 06:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:57 INFO - https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:34:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:34:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:34:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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 06:34:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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 06:35:01 INFO - Downloaded 53017379 bytes. 06:35:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:35:01 INFO - mkdir: /builds/slave/test/properties 06:35:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:01 INFO - Contents: 06:35:01 INFO - build_url:https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:35:01 INFO - Running post-action listener: _resource_record_post_action 06:35:01 INFO - Running post-action listener: set_extra_try_arguments 06:35:01 INFO - ##### 06:35:01 INFO - ##### Running populate-webroot step. 06:35:01 INFO - ##### 06:35:01 INFO - Running pre-action listener: _resource_record_pre_action 06:35:01 INFO - Running main action method: populate_webroot 06:35:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:01 INFO - '--tppagecycles', 06:35:01 INFO - '7'], 06:35:01 INFO - 'tests': ['tsvgm']}}, 06:35:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:35:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:35:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:35:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:01 INFO - 'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:01 INFO - 'tests': ['damp', 'tps']}, 06:35:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:01 INFO - 'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['damp', 'tps']}, 06:35:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:35:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:01 INFO - 'other': {'tests': ['a11yr', 06:35:01 INFO - 'ts_paint', 06:35:01 INFO - 'tpaint', 06:35:01 INFO - 'sessionrestore', 06:35:01 INFO - 'sessionrestore_no_auto_restore']}, 06:35:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['a11yr', 06:35:01 INFO - 'ts_paint', 06:35:01 INFO - 'tpaint', 06:35:01 INFO - 'sessionrestore', 06:35:01 INFO - 'sessionrestore_no_auto_restore']}, 06:35:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['a11yr', 06:35:01 INFO - 'ts_paint', 06:35:01 INFO - 'tpaint', 06:35:01 INFO - 'sessionrestore', 06:35:01 INFO - 'sessionrestore_no_auto_restore']}, 06:35:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['a11yr', 06:35:01 INFO - 'ts_paint', 06:35:01 INFO - 'tpaint', 06:35:01 INFO - 'sessionrestore', 06:35:01 INFO - 'sessionrestore_no_auto_restore']}, 06:35:01 INFO - 'other_l64': {'tests': ['a11yr', 06:35:01 INFO - 'ts_paint', 06:35:01 INFO - 'tpaint', 06:35:01 INFO - 'sessionrestore', 06:35:01 INFO - 'sessionrestore_no_auto_restore']}, 06:35:01 INFO - 'other_nol64': {'tests': ['a11yr', 06:35:01 INFO - 'ts_paint', 06:35:01 INFO - 'tpaint', 06:35:01 INFO - 'sessionrestore', 06:35:01 INFO - 'sessionrestore_no_auto_restore']}, 06:35:01 INFO - 'svgr': {'tests': ['tsvgx', 06:35:01 INFO - 'tsvgr_opacity', 06:35:01 INFO - 'tart', 06:35:01 INFO - 'tscrollx', 06:35:01 INFO - 'cart']}, 06:35:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['tsvgx', 06:35:01 INFO - 'tsvgr_opacity', 06:35:01 INFO - 'tart', 06:35:01 INFO - 'tscrollx', 06:35:01 INFO - 'cart']}, 06:35:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:01 INFO - 'tests': ['tp5o']}, 06:35:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:01 INFO - 'talos_options': ['--e10s'], 06:35:01 INFO - 'tests': ['tp5o']}, 06:35:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:01 INFO - 'talos_options': ['--xperf_path', 06:35:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:01 INFO - 'tests': ['tp5n']}, 06:35:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:01 INFO - 'talos_options': ['--e10s', 06:35:01 INFO - '--xperf_path', 06:35:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:01 INFO - 'tests': ['tp5n']}}, 06:35:01 INFO - 'talos.zip': {'path': '', 06:35:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:01 INFO - Running post-action listener: _resource_record_post_action 06:35:01 INFO - ##### 06:35:01 INFO - ##### Running create-virtualenv step. 06:35:01 INFO - ##### 06:35:01 INFO - Running pre-action listener: _resource_record_pre_action 06:35:01 INFO - Running main action method: create_virtualenv 06:35:01 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:01 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 06:35:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:01 INFO - Using real prefix '/usr' 06:35:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:03 INFO - Installing pip.................done. 06:35:03 INFO - Return code: 0 06:35:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35:03 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')]} 06:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:03 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')]} 06:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:03 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:03 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 06:35:03 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 06:35:03 INFO - Using env: {'DISPLAY': ':0', 06:35:03 INFO - 'HOME': '/home/cltbld', 06:35:03 INFO - 'LANG': 'en_US.UTF-8', 06:35:03 INFO - 'LANGUAGE': 'en_US:en', 06:35:03 INFO - 'LOGNAME': 'cltbld', 06:35:03 INFO - 'MAIL': '/var/mail/cltbld', 06:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:03 INFO - 'MOZ_NO_REMOTE': '1', 06:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:03 INFO - 'NO_EM_RESTART': '1', 06:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:03 INFO - 'PWD': '/builds/slave/test', 06:35:03 INFO - 'SHELL': '/bin/bash', 06:35:03 INFO - 'SHLVL': '1', 06:35:03 INFO - 'TERM': 'linux', 06:35:03 INFO - 'TMOUT': '86400', 06:35:03 INFO - 'USER': 'cltbld', 06:35:03 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:03 INFO - '_': '/tools/buildbot/bin/python'} 06:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:03 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 06:35:03 INFO - Cleaning up... 06:35:03 INFO - Return code: 0 06:35:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:35:03 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')]} 06:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:03 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')]} 06:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:03 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:03 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 06:35:03 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 06:35:03 INFO - Using env: {'DISPLAY': ':0', 06:35:03 INFO - 'HOME': '/home/cltbld', 06:35:03 INFO - 'LANG': 'en_US.UTF-8', 06:35:03 INFO - 'LANGUAGE': 'en_US:en', 06:35:03 INFO - 'LOGNAME': 'cltbld', 06:35:03 INFO - 'MAIL': '/var/mail/cltbld', 06:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:03 INFO - 'MOZ_NO_REMOTE': '1', 06:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:03 INFO - 'NO_EM_RESTART': '1', 06:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:03 INFO - 'PWD': '/builds/slave/test', 06:35:03 INFO - 'SHELL': '/bin/bash', 06:35:03 INFO - 'SHLVL': '1', 06:35:03 INFO - 'TERM': 'linux', 06:35:03 INFO - 'TMOUT': '86400', 06:35:03 INFO - 'USER': 'cltbld', 06:35:03 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:03 INFO - '_': '/tools/buildbot/bin/python'} 06:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:04 INFO - Downloading/unpacking psutil>=0.7.1 06:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:35:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:35:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:05 INFO - Installing collected packages: psutil 06:35:05 INFO - Running setup.py install for psutil 06:35:06 INFO - building 'psutil._psutil_linux' extension 06:35:06 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 06:35:06 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 06:35:06 INFO - building 'psutil._psutil_posix' extension 06:35:06 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 06:35:06 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 06:35:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:06 INFO - Successfully installed psutil 06:35:06 INFO - Cleaning up... 06:35:06 INFO - Return code: 0 06:35:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:35:06 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')]} 06:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:06 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')]} 06:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:06 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:06 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 06:35:06 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 06:35:06 INFO - Using env: {'DISPLAY': ':0', 06:35:06 INFO - 'HOME': '/home/cltbld', 06:35:06 INFO - 'LANG': 'en_US.UTF-8', 06:35:06 INFO - 'LANGUAGE': 'en_US:en', 06:35:06 INFO - 'LOGNAME': 'cltbld', 06:35:06 INFO - 'MAIL': '/var/mail/cltbld', 06:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:06 INFO - 'MOZ_NO_REMOTE': '1', 06:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:06 INFO - 'NO_EM_RESTART': '1', 06:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:06 INFO - 'PWD': '/builds/slave/test', 06:35:06 INFO - 'SHELL': '/bin/bash', 06:35:06 INFO - 'SHLVL': '1', 06:35:06 INFO - 'TERM': 'linux', 06:35:06 INFO - 'TMOUT': '86400', 06:35:06 INFO - 'USER': 'cltbld', 06:35:06 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:06 INFO - '_': '/tools/buildbot/bin/python'} 06:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:35:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:35:08 INFO - Installing collected packages: mozsystemmonitor 06:35:08 INFO - Running setup.py install for mozsystemmonitor 06:35:08 INFO - Successfully installed mozsystemmonitor 06:35:08 INFO - Cleaning up... 06:35:08 INFO - Return code: 0 06:35:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:35:08 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')]} 06:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:08 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')]} 06:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:08 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:08 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 06:35:08 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 06:35:08 INFO - Using env: {'DISPLAY': ':0', 06:35:08 INFO - 'HOME': '/home/cltbld', 06:35:08 INFO - 'LANG': 'en_US.UTF-8', 06:35:08 INFO - 'LANGUAGE': 'en_US:en', 06:35:08 INFO - 'LOGNAME': 'cltbld', 06:35:08 INFO - 'MAIL': '/var/mail/cltbld', 06:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:08 INFO - 'MOZ_NO_REMOTE': '1', 06:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:08 INFO - 'NO_EM_RESTART': '1', 06:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:08 INFO - 'PWD': '/builds/slave/test', 06:35:08 INFO - 'SHELL': '/bin/bash', 06:35:08 INFO - 'SHLVL': '1', 06:35:08 INFO - 'TERM': 'linux', 06:35:08 INFO - 'TMOUT': '86400', 06:35:08 INFO - 'USER': 'cltbld', 06:35:08 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:08 INFO - '_': '/tools/buildbot/bin/python'} 06:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:08 INFO - Downloading/unpacking blobuploader==1.2.4 06:35:08 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 06:35:08 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 06:35:08 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 06:35:08 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 06:35:08 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 06:35:08 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 06:35:10 INFO - Downloading blobuploader-1.2.4.tar.gz 06:35:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:35:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:35:10 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 06:35:10 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 06:35:10 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 06:35:10 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 06:35:10 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 06:35:10 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 06:35:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:35:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:35:10 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 06:35:10 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 06:35:10 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 06:35:10 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 06:35:10 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 06:35:10 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 06:35:11 INFO - Downloading docopt-0.6.1.tar.gz 06:35:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:35:11 INFO - Installing collected packages: blobuploader, requests, docopt 06:35:11 INFO - Running setup.py install for blobuploader 06:35:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:35:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:35:11 INFO - Running setup.py install for requests 06:35:11 INFO - Running setup.py install for docopt 06:35:11 INFO - Successfully installed blobuploader requests docopt 06:35:11 INFO - Cleaning up... 06:35:11 INFO - Return code: 0 06:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35: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')]} 06:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:11 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:11 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 06:35:11 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 06:35:11 INFO - Using env: {'DISPLAY': ':0', 06:35:11 INFO - 'HOME': '/home/cltbld', 06:35:11 INFO - 'LANG': 'en_US.UTF-8', 06:35:11 INFO - 'LANGUAGE': 'en_US:en', 06:35:11 INFO - 'LOGNAME': 'cltbld', 06:35:11 INFO - 'MAIL': '/var/mail/cltbld', 06:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:11 INFO - 'MOZ_NO_REMOTE': '1', 06:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:11 INFO - 'NO_EM_RESTART': '1', 06:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:11 INFO - 'PWD': '/builds/slave/test', 06:35:11 INFO - 'SHELL': '/bin/bash', 06:35:11 INFO - 'SHLVL': '1', 06:35:11 INFO - 'TERM': 'linux', 06:35:11 INFO - 'TMOUT': '86400', 06:35:11 INFO - 'USER': 'cltbld', 06:35:11 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:11 INFO - '_': '/tools/buildbot/bin/python'} 06:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:12 INFO - Running setup.py (path:/tmp/pip-TgIBZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:12 INFO - Running setup.py (path:/tmp/pip-oAd3pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:12 INFO - Running setup.py (path:/tmp/pip-EYpWAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:12 INFO - Running setup.py (path:/tmp/pip-LZn6Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:12 INFO - Running setup.py (path:/tmp/pip-5hOoDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:12 INFO - Running setup.py (path:/tmp/pip-axj5Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:12 INFO - Running setup.py (path:/tmp/pip-XnQW1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:12 INFO - Running setup.py (path:/tmp/pip-qh8Zds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:12 INFO - Running setup.py (path:/tmp/pip-sBTKZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:12 INFO - Running setup.py (path:/tmp/pip-MRWEoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:12 INFO - Running setup.py (path:/tmp/pip-rO_pim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:12 INFO - Running setup.py (path:/tmp/pip-x7s0si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:12 INFO - Running setup.py (path:/tmp/pip-A90dcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:13 INFO - Running setup.py (path:/tmp/pip-ZTDurt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:13 INFO - Running setup.py (path:/tmp/pip-oi34AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:13 INFO - Running setup.py (path:/tmp/pip-laf8eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:13 INFO - Running setup.py (path:/tmp/pip-zqp0Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:35:13 INFO - Running setup.py install for manifestparser 06:35:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:35:13 INFO - Running setup.py install for mozcrash 06:35:13 INFO - Running setup.py install for mozdebug 06:35:13 INFO - Running setup.py install for mozdevice 06:35:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:35:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:35:13 INFO - Running setup.py install for mozfile 06:35:13 INFO - Running setup.py install for mozhttpd 06:35:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:35:13 INFO - Running setup.py install for mozinfo 06:35:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Running setup.py install for mozInstall 06:35:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Running setup.py install for mozleak 06:35:14 INFO - Running setup.py install for mozlog 06:35:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Running setup.py install for moznetwork 06:35:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Running setup.py install for mozprocess 06:35:14 INFO - Running setup.py install for mozprofile 06:35:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Running setup.py install for mozrunner 06:35:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:35:14 INFO - Running setup.py install for mozscreenshot 06:35:14 INFO - Running setup.py install for moztest 06:35:15 INFO - Running setup.py install for mozversion 06:35:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:35:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:35:15 INFO - Cleaning up... 06:35:15 INFO - Return code: 0 06:35:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:15 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:15 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 06:35:15 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 06:35:15 INFO - Using env: {'DISPLAY': ':0', 06:35:15 INFO - 'HOME': '/home/cltbld', 06:35:15 INFO - 'LANG': 'en_US.UTF-8', 06:35:15 INFO - 'LANGUAGE': 'en_US:en', 06:35:15 INFO - 'LOGNAME': 'cltbld', 06:35:15 INFO - 'MAIL': '/var/mail/cltbld', 06:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:15 INFO - 'MOZ_NO_REMOTE': '1', 06:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:15 INFO - 'NO_EM_RESTART': '1', 06:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:15 INFO - 'PWD': '/builds/slave/test', 06:35:15 INFO - 'SHELL': '/bin/bash', 06:35:15 INFO - 'SHLVL': '1', 06:35:15 INFO - 'TERM': 'linux', 06:35:15 INFO - 'TMOUT': '86400', 06:35:15 INFO - 'USER': 'cltbld', 06:35:15 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:15 INFO - '_': '/tools/buildbot/bin/python'} 06:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:15 INFO - Running setup.py (path:/tmp/pip-CxCcM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:15 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)) 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:15 INFO - Running setup.py (path:/tmp/pip-mGuN8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:15 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)) 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:15 INFO - Running setup.py (path:/tmp/pip-wN7ZkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:15 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)) 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:15 INFO - Running setup.py (path:/tmp/pip-VK5EAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:15 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)) 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:15 INFO - Running setup.py (path:/tmp/pip-nNG5B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:15 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)) 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:15 INFO - Running setup.py (path:/tmp/pip-_mbazY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:15 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)) 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:15 INFO - Running setup.py (path:/tmp/pip-ISygT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:15 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)) 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:15 INFO - Running setup.py (path:/tmp/pip-nxUIOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:15 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)) 06:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:15 INFO - Running setup.py (path:/tmp/pip-PvGWOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:16 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)) 06:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:16 INFO - Running setup.py (path:/tmp/pip-DSPXPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:16 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)) 06:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:16 INFO - Running setup.py (path:/tmp/pip-eFqSl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:16 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)) 06:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:16 INFO - Running setup.py (path:/tmp/pip-E6esHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:16 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)) 06:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:16 INFO - Running setup.py (path:/tmp/pip-yVFlH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:16 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)) 06:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:16 INFO - Running setup.py (path:/tmp/pip-WN9C7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:16 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)) 06:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:16 INFO - Running setup.py (path:/tmp/pip-oYbYVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:16 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)) 06:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:16 INFO - Running setup.py (path:/tmp/pip-XdU0T1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:16 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)) 06:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:16 INFO - Running setup.py (path:/tmp/pip-mITmWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:16 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)) 06:35:16 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)) 06:35:16 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)) 06:35:16 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)) 06:35:16 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)) 06:35:16 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)) 06:35:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35:18 INFO - Downloading blessings-1.5.1.tar.gz 06:35:18 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 06:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:35:18 INFO - Installing collected packages: blessings 06:35:18 INFO - Running setup.py install for blessings 06:35:18 INFO - Successfully installed blessings 06:35:18 INFO - Cleaning up... 06:35:18 INFO - Return code: 0 06:35:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:18 INFO - Reading from file tmpfile_stdout 06:35:18 INFO - Current package versions: 06:35:18 INFO - argparse == 1.2.1 06:35:18 INFO - blessings == 1.5.1 06:35:18 INFO - blobuploader == 1.2.4 06:35:18 INFO - docopt == 0.6.1 06:35:18 INFO - manifestparser == 1.1 06:35:18 INFO - mozInstall == 1.12 06:35:18 INFO - mozcrash == 0.16 06:35:18 INFO - mozdebug == 0.1 06:35:18 INFO - mozdevice == 0.47 06:35:18 INFO - mozfile == 1.2 06:35:18 INFO - mozhttpd == 0.7 06:35:18 INFO - mozinfo == 0.9 06:35:18 INFO - mozleak == 0.1 06:35:18 INFO - mozlog == 3.1 06:35:18 INFO - moznetwork == 0.27 06:35:18 INFO - mozprocess == 0.22 06:35:18 INFO - mozprofile == 0.27 06:35:18 INFO - mozrunner == 6.11 06:35:18 INFO - mozscreenshot == 0.1 06:35:18 INFO - mozsystemmonitor == 0.0 06:35:18 INFO - moztest == 0.7 06:35:18 INFO - mozversion == 1.4 06:35:18 INFO - psutil == 3.1.1 06:35:18 INFO - requests == 1.2.3 06:35:18 INFO - wsgiref == 0.1.2 06:35:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:18 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')]} 06:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:18 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')]} 06:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:18 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:18 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 06:35:18 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 06:35:18 INFO - Using env: {'DISPLAY': ':0', 06:35:18 INFO - 'HOME': '/home/cltbld', 06:35:18 INFO - 'LANG': 'en_US.UTF-8', 06:35:18 INFO - 'LANGUAGE': 'en_US:en', 06:35:18 INFO - 'LOGNAME': 'cltbld', 06:35:18 INFO - 'MAIL': '/var/mail/cltbld', 06:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:18 INFO - 'MOZ_NO_REMOTE': '1', 06:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:18 INFO - 'NO_EM_RESTART': '1', 06:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:18 INFO - 'PWD': '/builds/slave/test', 06:35:18 INFO - 'SHELL': '/bin/bash', 06:35:18 INFO - 'SHLVL': '1', 06:35:18 INFO - 'TERM': 'linux', 06:35:18 INFO - 'TMOUT': '86400', 06:35:18 INFO - 'USER': 'cltbld', 06:35:18 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:18 INFO - '_': '/tools/buildbot/bin/python'} 06:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 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)) 06:35:18 INFO - Cleaning up... 06:35:18 INFO - Return code: 0 06:35:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:35:18 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')]} 06:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:18 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')]} 06:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:18 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:18 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 06:35:18 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 06:35:18 INFO - Using env: {'DISPLAY': ':0', 06:35:18 INFO - 'HOME': '/home/cltbld', 06:35:18 INFO - 'LANG': 'en_US.UTF-8', 06:35:18 INFO - 'LANGUAGE': 'en_US:en', 06:35:18 INFO - 'LOGNAME': 'cltbld', 06:35:18 INFO - 'MAIL': '/var/mail/cltbld', 06:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:18 INFO - 'MOZ_NO_REMOTE': '1', 06:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:18 INFO - 'NO_EM_RESTART': '1', 06:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:18 INFO - 'PWD': '/builds/slave/test', 06:35:18 INFO - 'SHELL': '/bin/bash', 06:35:18 INFO - 'SHLVL': '1', 06:35:18 INFO - 'TERM': 'linux', 06:35:18 INFO - 'TMOUT': '86400', 06:35:18 INFO - 'USER': 'cltbld', 06:35:18 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:18 INFO - '_': '/tools/buildbot/bin/python'} 06:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:19 INFO - Downloading/unpacking jsonschema 06:35:19 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 06:35:19 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 06:35:19 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 06:35:19 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 06:35:19 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 06:35:19 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 06:35:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:35:20 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 06:35:20 INFO - Downloading/unpacking functools32 (from jsonschema) 06:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:21 INFO - Downloading functools32-3.2.3-2.tar.gz 06:35:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:35:21 INFO - warning: no files found matching '*.txt' 06:35:21 INFO - no previously-included directories found matching 'build' 06:35:21 INFO - no previously-included directories found matching 'dist' 06:35:21 INFO - no previously-included directories found matching '.git*' 06:35:21 INFO - Installing collected packages: jsonschema, functools32 06:35:21 INFO - Running setup.py install for functools32 06:35:21 INFO - warning: no files found matching '*.txt' 06:35:21 INFO - no previously-included directories found matching 'build' 06:35:21 INFO - no previously-included directories found matching 'dist' 06:35:21 INFO - no previously-included directories found matching '.git*' 06:35:21 INFO - Successfully installed jsonschema functools32 06:35:21 INFO - Cleaning up... 06:35:21 INFO - Return code: 0 06:35:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:35:21 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')]} 06:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:21 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')]} 06:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:21 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 0x7f0433248f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', '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 06:35:21 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 06:35:21 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 06:35:21 INFO - Using env: {'DISPLAY': ':0', 06:35:21 INFO - 'HOME': '/home/cltbld', 06:35:21 INFO - 'LANG': 'en_US.UTF-8', 06:35:21 INFO - 'LANGUAGE': 'en_US:en', 06:35:21 INFO - 'LOGNAME': 'cltbld', 06:35:21 INFO - 'MAIL': '/var/mail/cltbld', 06:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:21 INFO - 'MOZ_NO_REMOTE': '1', 06:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:21 INFO - 'NO_EM_RESTART': '1', 06:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:21 INFO - 'PWD': '/builds/slave/test', 06:35:21 INFO - 'SHELL': '/bin/bash', 06:35:21 INFO - 'SHLVL': '1', 06:35:21 INFO - 'TERM': 'linux', 06:35:21 INFO - 'TMOUT': '86400', 06:35:21 INFO - 'USER': 'cltbld', 06:35:21 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:21 INFO - '_': '/tools/buildbot/bin/python'} 06:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:21 INFO - Downloading/unpacking flake8 06:35:21 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 06:35:21 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 06:35:21 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 06:35:21 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 06:35:21 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 06:35:21 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 06:35:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:35:23 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 06:35:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:35:23 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 06:35:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 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 06:35:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:35:23 INFO - no previously-included directories found matching 'docs/_build' 06:35:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:35:23 INFO - Running setup.py install for pep8 06:35:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:35:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:35:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:35:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:35:24 INFO - no previously-included directories found matching 'docs/_build' 06:35:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:35:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:35:24 INFO - Cleaning up... 06:35:24 INFO - Return code: 0 06:35:24 INFO - Running post-action listener: _resource_record_post_action 06:35:24 INFO - Running post-action listener: _start_resource_monitoring 06:35:24 INFO - Starting resource monitoring. 06:35:24 INFO - ##### 06:35:24 INFO - ##### Running install step. 06:35:24 INFO - ##### 06:35:24 INFO - Running pre-action listener: _resource_record_pre_action 06:35:24 INFO - Running main action method: install 06:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:24 INFO - Reading from file tmpfile_stdout 06:35:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:35:24 INFO - Reading from file tmpfile_stdout 06:35:24 INFO - Output received: 06:35:24 INFO - Usage: mozinstall [options] installer 06:35:24 INFO - Options: 06:35:24 INFO - -h, --help show this help message and exit 06:35:24 INFO - -d DEST, --destination=DEST 06:35:24 INFO - Directory to install application into. [default: 06:35:24 INFO - "/builds/slave/test"] 06:35:24 INFO - --app=APP Application being installed. [default: firefox] 06:35:24 INFO - mkdir: /builds/slave/test/build/application 06:35:24 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'] 06:35:24 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 06:35:39 INFO - Reading from file tmpfile_stdout 06:35:39 INFO - Output received: 06:35:39 INFO - /builds/slave/test/build/application/firefox/firefox 06:35:39 INFO - Running post-action listener: _resource_record_post_action 06:35:39 INFO - ##### 06:35:39 INFO - ##### Running run-tests step. 06:35:39 INFO - ##### 06:35:39 INFO - Running pre-action listener: _resource_record_pre_action 06:35:39 INFO - Running main action method: run_tests 06:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:35:39 INFO - Python 2.7.3 06:35:39 INFO - Return code: 0 06:35:39 INFO - grabbing minidump binary from tooltool 06:35:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:39 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 0x12bb0b0>, '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 0x12bbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bc440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:35:39 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 06:35:39 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 06:35:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:35:39 INFO - Return code: 0 06:35:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:35:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:35:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:35:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:35:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:35:40 INFO - Return code: 0 06:35:40 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/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] in /builds/slave/test/build 06:35:40 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/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost 06:35:40 INFO - Using env: {'DISPLAY': ':0', 06:35:40 INFO - 'HOME': '/home/cltbld', 06:35:40 INFO - 'LANG': 'en_US.UTF-8', 06:35:40 INFO - 'LANGUAGE': 'en_US:en', 06:35:40 INFO - 'LOGNAME': 'cltbld', 06:35:40 INFO - 'MAIL': '/var/mail/cltbld', 06:35:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:35:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:40 INFO - 'MOZ_NO_REMOTE': '1', 06:35:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:40 INFO - 'NO_EM_RESTART': '1', 06:35:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:40 INFO - 'PWD': '/builds/slave/test', 06:35:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:35:40 INFO - 'SHELL': '/bin/bash', 06:35:40 INFO - 'SHLVL': '1', 06:35:40 INFO - 'TERM': 'linux', 06:35:40 INFO - 'TMOUT': '86400', 06:35:40 INFO - 'USER': 'cltbld', 06:35:40 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781', 06:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:40 INFO - '_': '/tools/buildbot/bin/python'} 06:35:40 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/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] with output_timeout 3600 06:35:41 INFO - mozversion INFO | application_buildid: 20151218054054 06:35:41 INFO - mozversion INFO | application_changeset: 9765236f55225dd74caee557f9ee3193467d4e6d 06:35:41 INFO - mozversion INFO | application_display_name: Nightly 06:35:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:35:41 INFO - mozversion INFO | application_name: Firefox 06:35:41 INFO - mozversion INFO | application_remotingname: firefox 06:35:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:35:41 INFO - mozversion INFO | application_vendor: Mozilla 06:35:41 INFO - mozversion INFO | application_version: 46.0a1 06:35:41 INFO - mozversion INFO | platform_buildid: 20151218054054 06:35:41 INFO - mozversion INFO | platform_changeset: 9765236f55225dd74caee557f9ee3193467d4e6d 06:35:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:35:41 INFO - mozversion INFO | platform_version: 46.0a1 06:35:41 INFO - 2015-12-18 06:35:41,052 DEBUG : using testdate: 1450449341 06:35:41 INFO - 2015-12-18 06:35:41,053 DEBUG : actual date: 1450449341 06:35:41 INFO - 2015-12-18 06:35:41,061 INFO : starting webserver on 'localhost:45015' 06:35:41 INFO - 2015-12-18 06:35:41,062 INFO : Starting test suite talos-linux64-ix-032.e 06:35:41 INFO - 2015-12-18 06:35:41,062 INFO : Starting test dromaeo_css 06:35:41 INFO - 2015-12-18 06:35:41,063 DEBUG : operating with platform_type : linux_ 06:35:41 INFO - 2015-12-18 06:35:41,064 INFO : Initialising browser for dromaeo_css test... 06:35:41 INFO - 2015-12-18 06:35:41,080 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMM3Sf/profile http://localhost:45015/getInfo.html 06:35:46 INFO - 2015-12-18 06:35:46,836 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:35:46 INFO - 2015-12-18 06:35:46,836 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:35:46 INFO - 2015-12-18 06:35:46,836 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:35:46 INFO - 2015-12-18 06:35:46,836 DEBUG : BROWSER_OUTPUT: __metrics 06:35:46 INFO - 2015-12-18 06:35:46,978 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] 06:35:47 INFO - 2015-12-18 06:35:47,925 INFO : Browser initialized. 06:35:47 INFO - 2015-12-18 06:35:47,926 INFO : Running cycle 1/1 for dromaeo_css test... 06:35:47 INFO - 2015-12-18 06:35:47,926 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMM3Sf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:35:59 INFO - 2015-12-18 06:35:59,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 150212608 06:35:59 INFO - 2015-12-18 06:35:59,888 DEBUG : BROWSER_OUTPUT: 06:36:49 INFO - 2015-12-18 06:36:49,518 DEBUG : BROWSER_OUTPUT: 1450449409516 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] 06:39:01 INFO - 2015-12-18 06:39:01,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45015/tests/dromaeo/cssquery-ext.html) 06:39:02 INFO - 2015-12-18 06:39:02,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 155381760 06:39:02 INFO - 2015-12-18 06:39:02,692 DEBUG : BROWSER_OUTPUT: 06:42:04 INFO - 2015-12-18 06:42:04,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/dromaeo/cssquery-ext.html (next: http://localhost:45015/tests/dromaeo/cssquery-jquery.html) 06:42:05 INFO - 2015-12-18 06:42:05,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 151805952 06:42:05 INFO - 2015-12-18 06:42:05,239 DEBUG : BROWSER_OUTPUT: 06:45:07 INFO - 2015-12-18 06:45:07,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45015/tests/dromaeo/cssquery-mootools.html) 06:45:07 INFO - 2015-12-18 06:45:07,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 152821760 06:45:07 INFO - 2015-12-18 06:45:07,607 DEBUG : BROWSER_OUTPUT: 06:48:09 INFO - 2015-12-18 06:48:09,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45015/tests/dromaeo/cssquery-prototype.html) 06:48:10 INFO - 2015-12-18 06:48:10,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 151793664 06:48:10 INFO - 2015-12-18 06:48:10,011 DEBUG : BROWSER_OUTPUT: 06:51:12 INFO - 2015-12-18 06:51:12,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45015/tests/dromaeo/cssquery-yui.html) 06:51:13 INFO - 2015-12-18 06:51:13,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 152481792 06:51:13 INFO - 2015-12-18 06:51:13,278 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/dromaeo/cssquery-yui.html (next: http://localhost:45015/tests/dromaeo/cssquery-dojo.html) 06:54:15 INFO - 2015-12-18 06:54:15,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 155394048 06:54:15 INFO - 2015-12-18 06:54:15,850 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,850 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:54:15 INFO - 2015-12-18 06:54:15,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:54:15 INFO - 2015-12-18 06:54:15,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:54:15 INFO - 2015-12-18 06:54:15,851 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:54:15 INFO - 2015-12-18 06:54:15,852 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2671.9866400667993;2699.2442116207467;2730.6177135201074;2742.794290428217;2747.3955729739464;4566.269396896497;4692.835750748724;4743.833965811197;4744.881377965548;4822.469528351879;4601.493835678073;4669.439667239927;4727.645426593002;4768.356271903292;4770.880727981802;4366.7816609169495;4381.583749543788;4406.162829062484;4447.35513350564;4457.732536047832;4434.002349471375;4442.067165895166;4498.98772776126;4511.59395654391;4552.248878934972;4210.115875666113;4245.490541135053;4307.138572285556;4342.1966936116605;4348.239058164809;4437;4444.622207112399;4445.9110817783785;4463.352813841975;4474.82100715971;4194;4413.9117217655785;4424.911501769947;4457.108578284357;4470.240059189913;4501.234790085693;4603.194440972817;4607.792649330788;4608;4614.353990441341;5108.463611320833;5134.358205224347;5145.3568303962;5145.614078944094;5156.097682905476;4943.703377797344;5112.182050871843;5165.147750621143;5174.974125129388;5216.061109000379;4625.213713668684;4704.694194877322;4716.669833111718;4717.95282047182;4770.7376094314795;5209.791608335624;5241.816536421207;5245.580353571705;5250.684958902478;5289.920651190235;4843.24929635907;4891.657583969088;4972.8756781080765;5046.646734728607;5090.261912022736;5135.332406787168;5142.280080788692;5154.92267615986;5162.9741851291255;5169.638125331191;5092.9745351273;5115.2071428928575;5117.462666420047;5127.102757017507;5177.352830896138;4738.099761045391;4898.4121905371585;4902.240152776325;4905.435874874435;5079.339685840817;4138.896527586774;4210.894727631834;4223;4228.640565551901;4258.850940217139;3707.684846788053;3712.6844218241754;3714.5542534895985;3742.2328422673286;3748.737588368788;4235.8093885775215;4336.3278691802825;4355.499117601453;4372.497162826252;4403.911921761547;5163.509466600667;5168.2764412982215;5186.870328241749;5192.45479224676;5195.922061169085;4426.380306757057;4437.023854751949;4440.33394990754;4463.464384273908;4496.100779844044;4315.050688848449;4459.554044595579;4471.061077173765;4546.477155127137;4553.749543775058;4874.4150701916;4898.14282500561;4905.877353066202;4907.484714104968;4937.407511098691;5172.172452407597;5183.0670479314085;5197.974010130077;5200.843974680765;5240.371155461369;4670.859874203779;4775.5463230993;4809.639277054305;4927.876803079952;4953.1579631463455;5066.847994560169;5076.314697515788;5088.363954505687;5108.361454818148;5150.845474635767;4923.8276660316715;5151.330327057459;5182.637215394886;5184.0927837629015;5202.73986300691;4835.274708793709;4924;4936.234883593049;4946.307516947558;4950.975245123751;4888.560029597354;4891.828785992473;4898.510148985073;4908.705477671208;4964.578010868972;4709.317149013305;4780.6414518911915;4793.400824896888;4860.878478038077;4863.051704917507;4938.975305123451;5014.598832093497;5035.723035233097;5036.1942089267;5074.822381216787;4908;4916.139675556835;4926.556609905126;4927.507249275044;4992.525710057684 06:54:15 INFO - 2015-12-18 06:54:15,854 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.8472835241956;561.8369974153501;581.8080033588916;587.500624469201;588.9869424589705;26794.866025669868;35323.82338088309;35700;35728.82135589325;35792.46311305332;40168.79915600418;40346;40560;40687.59312406882;40882.59117408825;7751.6124193790365;7932.20677932205;7945.165757595427;7948.403869709766;7984.201579841998;7784.727534536292;7886.171951945049;7927.28654421102;7940.1265860755275;7948.8410231795615;7941.404394670394;7989.32090772285;8028.157043510435;8044.155363686817;8074.3136833369235;7937.087234967966;7940.1265860755275;7952.920470795276;8031;8039.437239393244;7856.528608283521;7918.2477664621765;7938.6427610757655;7949.682012719484;7987.041555013436;36036.81981590101;36136.096597585005;36515.63484365176;36697.449538256944;36741.632583674356;2915.620969274002;2923.6199294091844;3075.4617941860083;3455.1362159460136;3539.628339024417;27807.165785026482;28052.719472805216;28127;28387.432251355065;28929.079212941422;3301.7193538549254;3541.097020259843;3554.5023696682483;3557.2529768748595;3561.857525698969;218385;220445;220742;220773;221201;52918.47081529212;54154.458455415726;57701.71149144227;57744;58123.70938145367;51560;51712;51721;51766.74116629468;51798.741006294724;12814.615561533168;12885.613431597067;12913.160644558073;12978.545750898862;13123.868761312455;10128.898711012944;10147.543360548645;10148.238882083873;10166.694999150037;10177.796444071226;19731.40805775829;20107.59784804296;20147.496312592302;20179.394618161186;20206.191752330036;7521.623918804147;7790.883136752953;7842.098158711707;7852.254035866584;7856.960715196387;847.3179090831816;884.6240347852266;942.5098948546854;959.031378307914;1060.9522571484301;26321.605175922377;30321;30515.69484305173;30795.538066929013;31755.52366714501;989.4360214677565;1012.8075665623508;1023.0792286941663;1050.5272627317738;1063.574570171922;13660.453581856615;13704.24626645524;13890.722185556233;13932.164070155823;14074.577762667137;329554;334618;335017;335708;336016;48387;49162.508374916506;49181.262281065814;49349.25976110361;49361.50638493641;1219.0795949058404;1226.7117227451542;1237.07219585311;1244.9813252801396;1245.3710876007558;26326.21021369362;26544.070957516393;26584.202473925812;26615.866920665274;27028.054018109273;40978.38532421956;41561;41589.79205103955;41663.583364167185;41751.58248417477;257656;259452;259522;259535;260681;29876.85061574765;42270.78864605657;42634.18838131957;43230.783846080565;43863;38021.619783801805;38609.613903860605;38947.02632434212;39548.604513955645;39789;32211.295700994684;33351.49972750459;33394.666053339155;33439.49840752439;33955.4906676405;33144;33354;33356.33287334191;33649.49525757066;33878.8306058478;38001;38183.618163818006;38333.80833095816;38885.41671874981;39266;29017.12948611545;29888.70111298946;30195.547066793577;30252.5462118064;30569.08292751221;23345.639592895357;23744.643830342906;23754.524909501368;23943;23975.640365394185 06:54:15 INFO - 2015-12-18 06:54:15,857 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.1782082421062;326.1259823672558;328.0764647517238;328.55972996185125;333.8314151353566;10179.287449878511;10387.324823886442;14775.704485910275;15216.847831521682;16264.512064638051;15596.220188990534;15801.762973555406;15816;16309.83690163098;16710.415135470263;5407.459254074581;5567.359753628324;5696.060150075254;5735.225744524499;5738.139279108146;5674.659520428788;5744.052231381817;5759.539236861041;5761.423857614247;5765.135229715555;5590.552755779528;5665.716714164296;6127.816165515042;6327.968360158193;6344.080108384282;6253.6873156342;6298.149749783766;6304.968475157618;6664.733410663568;6670.7331706731675;6363.172787537591;6389.872202555923;6393.904091438632;6394.488440924715;6395.616263024187;20295.5940881183;20719.792802071937;21136.15455381783;21153.048112834804;21295.254666086767;2009.1461129020108;2010.105503051143;2014.1741885826887;2028.6652702304102;2076.252549082329;13673.453061877612;13723.45106195751;13868.791968120486;14002.649933751636;14013.719725605431;1796.8562514998769;1809.1225755508567;1836.2403823677114;1852.870299079065;1871.0551171658226;58429.415705842825;62464.37535624631;62611.37388626101;62820;64461.67769161171;15014.774778378332;15460.845391545941;15472.845271547141;15481.767773483407;15517.844821551866;23264;23301.7669823303;23557.057717691445;23566.29301120969;23589.882050589982;8718.17177368149;8742.25690816275;8750.124987501198;8764.298856091498;8801.47191168532;7324.853502929912;7325.04774379338;7359.889601655979;7365.2634736525915;7368.1526624438875;7408.666610002563;7475.8504829903095;7497.137829149718;7535.924640753632;7594.620268986529;1704.914754262282;1742.8082910879793;3059.005823107499;3105.48759454692;3145.0564830550743;371.31307081898814;377.3415390144161;378.3832353264217;784.1374488063085;948.3977674176809;9290.628374865066;9298.070192980784;9488.762780930532;9580.281478889112;9637.518124093907;393.0664671405412;394.9940750888739;397.3979421176919;408.244747217645;408.65060373380925;5162.870928226749;5232.633715639945;5262.368515778131;5277.525022747971;5362.1420572708175;456895;459616;463860;467220;467982;70154;72738.63630681919;72916;73011;73309.6334518324;433.58159376202116;434.6283927242226;435.44915681662724;436.2844934307738;438.6622300828344;8862.512561809162;8991.595378208127;9066.09339066088;9183.678571249975;9192.35653504275;30622.387552248383;30816.84591577028;31007.0697879064;31053.689463105078;31670.366592668477;45264;45480.31779523243;46393.30410043919;47157.528424716686;47327.29009064798;8648.56757162152;8850.822983540422;8858.468491890508;8867.467951922905;8972.730818075468;12397.814032789696;12722.427490762753;16459.67080658404;16540.66918661644;16552.503424897273;12844.42200100979;12882.09825312219;12959.870401296244;13213.933930330288;13381.732365352444;10362.948185259025;13118.606441806762;13249.13880597758;13873.79189312141;13916.721665566429;13699.589012329647;14218.511760442088;14252.144871307755;14489.203093829941;14690.48583299622;8717.825643487222;8803.955980220058;8910.777230569287;8913.50975696317;8934.597943092707;11697;13724;13903.652408689864;14132.081414708011;14154.363053662404 06:54:15 INFO - 2015-12-18 06:54:15,857 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1479.5709244319148;1666.4500714764129;1716.562276619462;1732.099308359653;1757.6924038293296;6154.415330543602;6371;6552.901706474401;7069.858602827947;7082.858342833147;6647.6343801090925;6734.764283250087;6781.186257649077;6798.45612351012;6809.250982391933;1966.5280332720115;1999.1004048178306;2008.0562135796151;2008.3472871316808;2008.3874418302412;2030.7969203079722;2051.3743308290964;2058.6911963205566;2080.2303147835246;2085.551606404623;2007.2874129683971;2036.3178335257705;2045.427280361501;2061.4331058958755;2063.432556047084;1977.2486455147096;1986.692062730279;1999.6900480425484;2001.2995451591971;2002.6682256299543;2015.334939469986;2033.6339458897392;2051.0770153431017;2055.0238636647623;2058.7750288578272;7050.471214658921;7079.185893622248;7122.857542849114;7140.321669441395;7147.642617869085;4110.321796903508;4134.627883490471;4149.294619914622;4162.583741625813;4173.061061261223;2596;2605.557055300603;2637.9604305935427;2661.055325359489;2670.505956398053;897.5736525150501;915.3409545127497;915.514777168102;927.6938610258599;930.2929773372218;9449.811003779885;9450.243980481546;9451.385659932082;9477.28920330978;9490.525473726286;3721.0697325668584;3749.6625303722794;3786.413105968524;3789.621037896188;3793.867214647474;8090.271875531231;8137.75586732399;8138.023437187576;8151.510909345339;8160.224778646019;4106.014556506417;4124.030852749602;4129.6489798367475;4132.33882578786;4141.503019637603;3193.409219294438;3224.661410551905;3655.1775850433974;3731.1045349116016;3756.323861704919;3377.919065898938;3390.5592273004845;3393;3406.335764525894;3459.757816952789;1075.0861767497565;1082.7494244148022;1083.7940791249637;1084.7017070305728;1093.9726506837392;885.3536918049859;951.0442005784142;1170.1750266062575;1173.5833779008499;1186.2941549777868;6632.83417914556;6642.4021838034805;6654.201495820533;6665.700043498055;6688.4649228061635;1027.6300531808542;1028.9794204115876;1050.0969166516788;1051.6687243518268;1054.0144964458257;5381.192821076792;5401.756920938567;5414.8917021659345;5434.3207099112615;5451.04606693827;8111.3916456266015;8132.2680958714;8321.875171872427;8369.748907532783;8414.747557573282;8262.917370826215;8320.502309584333;8321.750347489586;8322.042965058974;8324.29243514296;6349.555531112777;6630.801075967825;6786.76246331376;6806.829829254309;6818.18181818185;6597.175353080865;6674.132362792806;6734.831629209309;6736.461083113241;6740.39336459721;7660.846783064419;7661.233876612294;7683.462157648911;7709;7821.569813660303;7771.067471903408;7922;7943.642536086006;8016.959915200387;8064.919350806417;5114.74426278692;5590.720463976866;5691.8292451226525;6040.637561746309;6127.6936153193055;6737.191537015589;6744.460443164437;6772.018057381751;6776.661166941732;6786.558873673195;6333.398327158912;6387.137736405526;6457.515686323639;6484.643344616092;6501.772437964649;6277.5605707600025;6470.902936456051;6483.837904052436;6531.444827189552;6588.110605068255;6559.0817285579105;6565.474762018932;6580.5722628029025;6618.8345291368105;6634.170728658918;6002.735273130848;6042.063480160582;6054.576179667381;6060.212172417558;6080.939190608037;5956.434138756811;5970.253718285215;5991.071383935497;5997;5999.370066142992 06:54:15 INFO - 2015-12-18 06:54:15,858 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.3332601624394;307.6277703978186;308.6065266784849;311.31665993145054;311.50470751505117;5531.502164805172;5580.246666699994;5605.243292155557;5668.206451096849;5791.913121303184;5574.916376254359;5601.60788744788;5623.4938855503;5640.351359593648;5641.717914104299;4151.813168407429;4260.552641972579;4321.092570560186;4322.330038843984;4322.84870029549;4253.914921701564;4267.530571637118;4272.060146767706;4283.20760659279;4291.806868690916;4228.048689044971;4229.196452673982;4231.64031057359;4232.0054787125;4232.76719780412;4228.619424251817;4230.386593943892;4236.068065025689;4241.448611680493;4248.723832950879;3616.8553257869653;3672.559292884871;3673.246984368198;3673.742838001341;3682.5396825396824;5286.81496147633;5394.487523685244;5399.892002159974;5431.782728690848;5447.945520544784;4901.338319326881;4910.656254062217;4919.606431485473;4921.901561968776;4928.1129396708575;5930.1401296812155;5932.762689492415;5933.554983376221;5937.584369094165;5956.761729530857;3915.647591716731;4024.4566983457153;4039.3738970459626;4049.777262250575;4051.534073581546;6180.196574445338;6226.066090086478;6228.37716228378;6243.157173781527;6257.5932564383165;4104.692148088846;4121.649659778893;4121.793910304473;4124.587541245852;4129.2773764591075;4183.6234738873645;4188.497380314382;4188.748675079505;4191.266528357525;4192.601702838226;4766.809327626856;4792.496787837296;4842.201036828884;4849.854504364875;4862.975685121552;5843.970780146072;5908.556858235649;5916.26046744157;5921.230240068763;5926.259217597801;1448.9058211216238;1482.1847983608973;1482.3403585404392;1487.0259979713305;1488.1666266890577;985.6796541124163;994.0012027414518;1006.3207335048959;1009.7677534167183;1011.7672935224792;5110.897782044338;5118;5121.257417674491;5121.948780512147;5122.308488354099;6141.232345956755;6144.8771024580155;6161.476274516626;6168.136460895478;6177.413145751147;5034.748262586856;5034.84895453137;5059.19052951526;5064.696118232918;5107.693538387709;3231.4829627259523;3270.9509357359657;3289.3914625794305;3331.217163966466;3332.5334453176574;5833;5846.473817356373;5850.151727999416;5852.590318677737;5865.178874957509;6355.1420558224045;6384.106225128486;6409.8718025640155;6416.197975253093;6420.486361091102;5657.773689052474;5823.7670493181495;5834.445727655866;5838.036723940587;5846.41535846412;6186.721597528212;6194.163787888578;6199.5970261934635;6199.907001394892;6219.875602488016;6032.54755893301;6057.939420605738;6065.393460654076;6067.059605761114;6070.392960704071;5694.800681976111;5820.417958204315;5820.738066787089;5821.214136091573;5825.271841019872;4109.075458021921;4142.109446469024;4142.502899652061;4143.709940304149;4145.66834653221;5914.3198532167635;6093.36019717941;6155.015197568547;6169.938300616936;6192.473639740492;5838.970805145947;5892.7642894283745;5920.526357891445;5937.4656280933195;5955.464008239279;5907.232059832194;5912.231409916683;5920.674362910081;5929.52563794904;5937.109433584997;5671.6597004179885;5777.7977770777825;5795.188673585786;5795.188673585786;5810.302763668386;5966.19456373384;5983.311919129356;5988.401159883977;5989.760409583568;5993.400659933972;5827.329857066492;5828.970855145697;5833.491598612637;5838.416158384128;5839.532837373085 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: |5;yui.html;596.5853731656498;661.6724721262975;696.143743195869;714.2179313651551;728.4718579030204;10978.231523793327;11344.262622929504;11369.715757106067;11383.487743051563;11389.544418223282;13322.600321990332;13470.461181552726;13530.458781648747;13546.729065418685;13560.796588051187;784.701813310941;787.1184273613546;799.6801279488193;802.7631848604676;803.0844836885955;793.0919097633207;793.3811626931004;802.3541049455187;804.8148925747082;806.5644551941945;819.942604017719;824.3693574415577;829.8713699376606;831.3723139030024;831.9916800831975;818.7175424478545;820.6430202861774;821.6631181215703;821.8972628421448;824.3405275779412;609.704293417692;613.2120225510198;613.5214532664529;613.9693015349214;614.5053232148119;11412.942935285271;11566.595169169039;11640.94179529097;11656.41717914101;11663.183577149603;10216.284860059799;10787.298825576312;11028.558857645685;11094.667159985212;11410.600628978029;8821.42660727057;9007.324450666161;9149.862752058725;9342;9607.279454040974;3213.967860321414;3224.2423030587793;3256.2022304535303;3256.6417694053634;3304.0913748719054;40381;40387.798061009504;40396.19207615861;40585;40726.18547629031;8056.152270569969;8121.75634730959;8490.232497921004;8501.787455313543;8667.393282470166;14810.778383242385;14826;14826.777598336033;14847.40610375573;14986.325615347336;6038.939610603926;6063.484128967758;6141.539384546088;6152.477039451607;6283.874322513524;3487.3548393547276;3527.700145487611;3545.3618348697482;3574.410222313289;3635.4546817977516;2457.054034196847;2457.348802567321;2463.1625247415964;2464.0636558108163;2586.4439145583788;478.3160081084014;482.6114977443122;484.08507920031167;485.434468843793;495.22250067393844;437.1061179887075;439.10641843847617;439.59118020240845;446.3193629714711;456.4841728846382;6775.4240889524945;6888.311168883171;6889.237981495913;6923.273056329113;7061.9293807062295;518.8786675512714;525.9631825772236;539.719345940109;545.7625932719279;554.1075585443976;3299.686529779667;3308.8180150091976;3310.652381499956;3383.120388698956;3426.1605906553054;45611.77194114008;47020.529794701615;48520.27219591709;48750.756246218545;48911.75544122328;37913.81043094822;37947.43078853819;38212;38288.23423531514;38687.61312386896;38662.22675546473;40044.194696636005;40748.99999999941;40872.56946006935;41198.1760364797;7129.39400150993;7150.956382235908;7193.604351760703;7268.96365518169;7415.184329723834;31477;31606.209844753146;31938.76940862303;32428.189295267806;32459.837700811346;36012;36376.27247455089;38447.615523844404;39853.80073099616;39959;9306.836645419322;9380.155785979294;9714.902850971683;9732.513374331396;9813.01869813013;10275.332103413255;10281.434521101412;10575.471226438802;10587.894121058998;11208.887911120784;9848.057683191595;9873.605055797687;9920;9977.850332245167;10019;9252.352335336462;9263.907360926305;9394.248460123037;9591.088846559845;9591.28065395112;9917.206623469961;10019.198464122706;10051.69844904654;10056.944020877703;10169.389836609827;8693.34799889998;8747.03782583928;8911.643534258557;9185.127412895765;9230.723078307661;8068.838623227385;8240.423170378255;8280.71017514384;8661.13388661129;8916.108389161032 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,340 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: __startTimestamp1450450455848__endTimestamp 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,860 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4704.67 Median:4835.27 stddev:501.33 (10.4%) stddev-sans-first:476.83 06:54:15 INFO - 2015-12-18 06:54:15,861 DEBUG : BROWSER_OUTPUT: Values: 2672.0 2699.2 2730.6 2742.8 2747.4 4566.3 4692.8 4743.8 4744.9 4822.5 4601.5 4669.4 4727.6 4768.4 4770.9 4366.8 4381.6 4406.2 4447.4 4457.7 4434.0 4442.1 4499.0 4511.6 4552.2 4210.1 4245.5 4307.1 4342.2 4348.2 4437.0 4444.6 4445.9 4463.4 4474.8 4194.0 4413.9 4424.9 4457.1 4470.2 4501.2 4603.2 4607.8 4608.0 4614.4 5108.5 5134.4 5145.4 5145.6 5156.1 4943.7 5112.2 5165.1 5175.0 5216.1 4625.2 4704.7 4716.7 4718.0 4770.7 5209.8 5241.8 5245.6 5250.7 5289.9 4843.2 4891.7 4972.9 5046.6 5090.3 5135.3 5142.3 5154.9 5163.0 5169.6 5093.0 5115.2 5117.5 5127.1 5177.4 4738.1 4898.4 4902.2 4905.4 5079.3 4138.9 4210.9 4223.0 4228.6 4258.9 3707.7 3712.7 3714.6 3742.2 3748.7 4235.8 4336.3 4355.5 4372.5 4403.9 5163.5 5168.3 5186.9 5192.5 5195.9 4426.4 4437.0 4440.3 4463.5 4496.1 4315.1 4459.6 4471.1 4546.5 4553.7 4874.4 4898.1 4905.9 4907.5 4937.4 5172.2 5183.1 5198.0 5200.8 5240.4 4670.9 4775.5 4809.6 4927.9 4953.2 5066.8 5076.3 5088.4 5108.4 5150.8 4923.8 5151.3 5182.6 5184.1 5202.7 4835.3 4924.0 4936.2 4946.3 4951.0 4888.6 4891.8 4898.5 4908.7 4964.6 4709.3 4780.6 4793.4 4860.9 4863.1 4939.0 5014.6 5035.7 5036.2 5074.8 4908.0 4916.1 4926.6 4927.5 4992.5 06:54:15 INFO - 2015-12-18 06:54:15,861 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,861 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43369.71 Median:3555.88 stddev:72061.05 (2026.5%) stddev-sans-first:72191.43 06:54:15 INFO - 2015-12-18 06:54:15,862 DEBUG : BROWSER_OUTPUT: Values: 535.8 561.8 581.8 587.5 589.0 26794.9 35323.8 35700.0 35728.8 35792.5 40168.8 40346.0 40560.0 40687.6 40882.6 7751.6 7932.2 7945.2 7948.4 7984.2 7784.7 7886.2 7927.3 7940.1 7948.8 7941.4 7989.3 8028.2 8044.2 8074.3 7937.1 7940.1 7952.9 8031.0 8039.4 7856.5 7918.2 7938.6 7949.7 7987.0 36036.8 36136.1 36515.6 36697.4 36741.6 2915.6 2923.6 3075.5 3455.1 3539.6 27807.2 28052.7 28127.0 28387.4 28929.1 3301.7 3541.1 3554.5 3557.3 3561.9 218385.0 220445.0 220742.0 220773.0 221201.0 52918.5 54154.5 57701.7 57744.0 58123.7 51560.0 51712.0 51721.0 51766.7 51798.7 12814.6 12885.6 12913.2 12978.5 13123.9 10128.9 10147.5 10148.2 10166.7 10177.8 19731.4 20107.6 20147.5 20179.4 20206.2 7521.6 7790.9 7842.1 7852.3 7857.0 847.3 884.6 942.5 959.0 1061.0 26321.6 30321.0 30515.7 30795.5 31755.5 989.4 1012.8 1023.1 1050.5 1063.6 13660.5 13704.2 13890.7 13932.2 14074.6 329554.0 334618.0 335017.0 335708.0 336016.0 48387.0 49162.5 49181.3 49349.3 49361.5 1219.1 1226.7 1237.1 1245.0 1245.4 26326.2 26544.1 26584.2 26615.9 27028.1 40978.4 41561.0 41589.8 41663.6 41751.6 257656.0 259452.0 259522.0 259535.0 260681.0 29876.9 42270.8 42634.2 43230.8 43863.0 38021.6 38609.6 38947.0 39548.6 39789.0 32211.3 33351.5 33394.7 33439.5 33955.5 33144.0 33354.0 33356.3 33649.5 33878.8 38001.0 38183.6 38333.8 38885.4 39266.0 29017.1 29888.7 30195.5 30252.5 30569.1 23345.6 23744.6 23754.5 23943.0 23975.6 06:54:15 INFO - 2015-12-18 06:54:15,862 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,862 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26394.80 Median:435.87 stddev:75707.30 (17369.4%) stddev-sans-first:75894.37 06:54:15 INFO - 2015-12-18 06:54:15,862 DEBUG : BROWSER_OUTPUT: Values: 324.2 326.1 328.1 328.6 333.8 10179.3 10387.3 14775.7 15216.8 16264.5 15596.2 15801.8 15816.0 16309.8 16710.4 5407.5 5567.4 5696.1 5735.2 5738.1 5674.7 5744.1 5759.5 5761.4 5765.1 5590.6 5665.7 6127.8 6328.0 6344.1 6253.7 6298.1 6305.0 6664.7 6670.7 6363.2 6389.9 6393.9 6394.5 6395.6 20295.6 20719.8 21136.2 21153.0 21295.3 2009.1 2010.1 2014.2 2028.7 2076.3 13673.5 13723.5 13868.8 14002.6 14013.7 1796.9 1809.1 1836.2 1852.9 1871.1 58429.4 62464.4 62611.4 62820.0 64461.7 15014.8 15460.8 15472.8 15481.8 15517.8 23264.0 23301.8 23557.1 23566.3 23589.9 8718.2 8742.3 8750.1 8764.3 8801.5 7324.9 7325.0 7359.9 7365.3 7368.2 7408.7 7475.9 7497.1 7535.9 7594.6 1704.9 1742.8 3059.0 3105.5 3145.1 371.3 377.3 378.4 784.1 948.4 9290.6 9298.1 9488.8 9580.3 9637.5 393.1 395.0 397.4 408.2 408.7 5162.9 5232.6 5262.4 5277.5 5362.1 456895.0 459616.0 463860.0 467220.0 467982.0 70154.0 72738.6 72916.0 73011.0 73309.6 433.6 434.6 435.4 436.3 438.7 8862.5 8991.6 9066.1 9183.7 9192.4 30622.4 30816.8 31007.1 31053.7 31670.4 45264.0 45480.3 46393.3 47157.5 47327.3 8648.6 8850.8 8858.5 8867.5 8972.7 12397.8 12722.4 16459.7 16540.7 16552.5 12844.4 12882.1 12959.9 13213.9 13381.7 10362.9 13118.6 13249.1 13873.8 13916.7 13699.6 14218.5 14252.1 14489.2 14690.5 8717.8 8804.0 8910.8 8913.5 8934.6 11697.0 13724.0 13903.7 14132.1 14154.4 06:54:15 INFO - 2015-12-18 06:54:15,862 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,862 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4925.24 Median:6070.58 stddev:2538.20 (41.8%) stddev-sans-first:2532.11 06:54:15 INFO - 2015-12-18 06:54:15,862 DEBUG : BROWSER_OUTPUT: Values: 1479.6 1666.5 1716.6 1732.1 1757.7 6154.4 6371.0 6552.9 7069.9 7082.9 6647.6 6734.8 6781.2 6798.5 6809.3 1966.5 1999.1 2008.1 2008.3 2008.4 2030.8 2051.4 2058.7 2080.2 2085.6 2007.3 2036.3 2045.4 2061.4 2063.4 1977.2 1986.7 1999.7 2001.3 2002.7 2015.3 2033.6 2051.1 2055.0 2058.8 7050.5 7079.2 7122.9 7140.3 7147.6 4110.3 4134.6 4149.3 4162.6 4173.1 2596.0 2605.6 2638.0 2661.1 2670.5 897.6 915.3 915.5 927.7 930.3 9449.8 9450.2 9451.4 9477.3 9490.5 3721.1 3749.7 3786.4 3789.6 3793.9 8090.3 8137.8 8138.0 8151.5 8160.2 4106.0 4124.0 4129.6 4132.3 4141.5 3193.4 3224.7 3655.2 3731.1 3756.3 3377.9 3390.6 3393.0 3406.3 3459.8 1075.1 1082.7 1083.8 1084.7 1094.0 885.4 951.0 1170.2 1173.6 1186.3 6632.8 6642.4 6654.2 6665.7 6688.5 1027.6 1029.0 1050.1 1051.7 1054.0 5381.2 5401.8 5414.9 5434.3 5451.0 8111.4 8132.3 8321.9 8369.7 8414.7 8262.9 8320.5 8321.8 8322.0 8324.3 6349.6 6630.8 6786.8 6806.8 6818.2 6597.2 6674.1 6734.8 6736.5 6740.4 7660.8 7661.2 7683.5 7709.0 7821.6 7771.1 7922.0 7943.6 8017.0 8064.9 5114.7 5590.7 5691.8 6040.6 6127.7 6737.2 6744.5 6772.0 6776.7 6786.6 6333.4 6387.1 6457.5 6484.6 6501.8 6277.6 6470.9 6483.8 6531.4 6588.1 6559.1 6565.5 6580.6 6618.8 6634.2 6002.7 6042.1 6054.6 6060.2 6080.9 5956.4 5970.3 5991.1 5997.0 5999.4 06:54:15 INFO - 2015-12-18 06:54:15,863 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,863 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4878.78 Median:5590.93 stddev:1468.54 (26.3%) stddev-sans-first:1431.89 06:54:15 INFO - 2015-12-18 06:54:15,864 DEBUG : BROWSER_OUTPUT: Values: 300.3 307.6 308.6 311.3 311.5 5531.5 5580.2 5605.2 5668.2 5791.9 5574.9 5601.6 5623.5 5640.4 5641.7 4151.8 4260.6 4321.1 4322.3 4322.8 4253.9 4267.5 4272.1 4283.2 4291.8 4228.0 4229.2 4231.6 4232.0 4232.8 4228.6 4230.4 4236.1 4241.4 4248.7 3616.9 3672.6 3673.2 3673.7 3682.5 5286.8 5394.5 5399.9 5431.8 5447.9 4901.3 4910.7 4919.6 4921.9 4928.1 5930.1 5932.8 5933.6 5937.6 5956.8 3915.6 4024.5 4039.4 4049.8 4051.5 6180.2 6226.1 6228.4 6243.2 6257.6 4104.7 4121.6 4121.8 4124.6 4129.3 4183.6 4188.5 4188.7 4191.3 4192.6 4766.8 4792.5 4842.2 4849.9 4863.0 5844.0 5908.6 5916.3 5921.2 5926.3 1448.9 1482.2 1482.3 1487.0 1488.2 985.7 994.0 1006.3 1009.8 1011.8 5110.9 5118.0 5121.3 5121.9 5122.3 6141.2 6144.9 6161.5 6168.1 6177.4 5034.7 5034.8 5059.2 5064.7 5107.7 3231.5 3271.0 3289.4 3331.2 3332.5 5833.0 5846.5 5850.2 5852.6 5865.2 6355.1 6384.1 6409.9 6416.2 6420.5 5657.8 5823.8 5834.4 5838.0 5846.4 6186.7 6194.2 6199.6 6199.9 6219.9 6032.5 6057.9 6065.4 6067.1 6070.4 5694.8 5820.4 5820.7 5821.2 5825.3 4109.1 4142.1 4142.5 4143.7 4145.7 5914.3 6093.4 6155.0 6169.9 6192.5 5839.0 5892.8 5920.5 5937.5 5955.5 5907.2 5912.2 5920.7 5929.5 5937.1 5671.7 5777.8 5795.2 5795.2 5810.3 5966.2 5983.3 5988.4 5989.8 5993.4 5827.3 5829.0 5833.5 5838.4 5839.5 06:54:15 INFO - 2015-12-18 06:54:15,864 DEBUG : BROWSER_OUTPUT: 06:54:15 INFO - 2015-12-18 06:54:15,864 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11734.39 Median:24502.85 stddev:13260.66 (54.1%) stddev-sans-first:13271.48 06:54:15 INFO - 2015-12-18 06:54:15,864 DEBUG : BROWSER_OUTPUT: Values: 596.6 661.7 696.1 714.2 728.5 10978.2 11344.3 11369.7 11383.5 11389.5 13322.6 13470.5 13530.5 13546.7 13560.8 784.7 787.1 799.7 802.8 803.1 793.1 793.4 802.4 804.8 806.6 819.9 824.4 829.9 831.4 832.0 818.7 820.6 821.7 821.9 824.3 609.7 613.2 613.5 614.0 614.5 11412.9 11566.6 11640.9 11656.4 11663.2 10216.3 10787.3 11028.6 11094.7 11410.6 8821.4 9007.3 9149.9 9342.0 9607.3 3214.0 3224.2 3256.2 3256.6 3304.1 40381.0 40387.8 40396.2 40585.0 40726.2 8056.2 8121.8 8490.2 8501.8 8667.4 14810.8 14826.0 14826.8 14847.4 14986.3 6038.9 6063.5 6141.5 6152.5 6283.9 3487.4 3527.7 3545.4 3574.4 3635.5 2457.1 2457.3 2463.2 2464.1 2586.4 478.3 482.6 484.1 485.4 495.2 437.1 439.1 439.6 446.3 456.5 6775.4 6888.3 6889.2 6923.3 7061.9 518.9 526.0 539.7 545.8 554.1 3299.7 3308.8 3310.7 3383.1 3426.2 45611.8 47020.5 48520.3 48750.8 48911.8 37913.8 37947.4 38212.0 38288.2 38687.6 38662.2 40044.2 40749.0 40872.6 41198.2 7129.4 7151.0 7193.6 7269.0 7415.2 31477.0 31606.2 31938.8 32428.2 32459.8 36012.0 36376.3 38447.6 39853.8 39959.0 9306.8 9380.2 9714.9 9732.5 9813.0 10275.3 10281.4 10575.5 10587.9 11208.9 9848.1 9873.6 9920.0 9977.9 10019.0 9252.4 9263.9 9394.2 9591.1 9591.3 9917.2 10019.2 10051.7 10056.9 10169.4 8693.3 8747.0 8911.6 9185.1 9230.7 8068.8 8240.4 8280.7 8661.1 8916.1 06:54:15 INFO - 2015-12-18 06:54:15,864 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:54:15 INFO - 2015-12-18 06:54:15,864 DEBUG : BROWSER_OUTPUT: 06:54:16 INFO - 2015-12-18 06:54:16,617 INFO : Browser exited with error code: 0 06:54:16 INFO - 2015-12-18 06:54:16,634 INFO : Completed test dromaeo_css (00:18:35) 06:54:16 INFO - 2015-12-18 06:54:16,634 INFO : Starting test kraken 06:54:16 INFO - 2015-12-18 06:54:16,634 DEBUG : operating with platform_type : linux_ 06:54:16 INFO - 2015-12-18 06:54:16,634 INFO : Initialising browser for kraken test... 06:54:16 INFO - 2015-12-18 06:54:16,640 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplWT6h3/profile http://localhost:45015/getInfo.html 06:54:22 INFO - 2015-12-18 06:54:22,354 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:54:22 INFO - 2015-12-18 06:54:22,354 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:54:22 INFO - 2015-12-18 06:54:22,354 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:54:22 INFO - 2015-12-18 06:54:22,355 DEBUG : BROWSER_OUTPUT: __metrics 06:54:22 INFO - 2015-12-18 06:54:22,516 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] 06:54:23 INFO - 2015-12-18 06:54:23,497 INFO : Browser initialized. 06:54:23 INFO - 2015-12-18 06:54:23,498 INFO : Running cycle 1/1 for kraken test... 06:54:23 INFO - 2015-12-18 06:54:23,498 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplWT6h3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:54:35 INFO - 2015-12-18 06:54:35,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 150618112 06:54:35 INFO - 2015-12-18 06:54:35,524 DEBUG : BROWSER_OUTPUT: 06:54:38 INFO - 2015-12-18 06:54:38,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45015/tests/kraken/driver.html?testName=audio-beat-detection) 06:54:38 INFO - 2015-12-18 06:54:38,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 150175744 06:54:38 INFO - 2015-12-18 06:54:38,719 DEBUG : BROWSER_OUTPUT: 06:54:41 INFO - 2015-12-18 06:54:41,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45015/tests/kraken/driver.html?testName=audio-dft) 06:54:42 INFO - 2015-12-18 06:54:42,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 150147072 06:54:42 INFO - 2015-12-18 06:54:42,075 DEBUG : BROWSER_OUTPUT: 06:54:44 INFO - 2015-12-18 06:54:44,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45015/tests/kraken/driver.html?testName=audio-fft) 06:54:45 INFO - 2015-12-18 06:54:45,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 145829888 06:54:45 INFO - 2015-12-18 06:54:45,576 DEBUG : BROWSER_OUTPUT: 06:54:47 INFO - 2015-12-18 06:54:47,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45015/tests/kraken/driver.html?testName=audio-oscillator) 06:54:48 INFO - 2015-12-18 06:54:48,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 146558976 06:54:48 INFO - 2015-12-18 06:54:48,296 DEBUG : BROWSER_OUTPUT: 06:54:50 INFO - 2015-12-18 06:54:50,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:54:51 INFO - 2015-12-18 06:54:51,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 146935808 06:54:51 INFO - 2015-12-18 06:54:51,168 DEBUG : BROWSER_OUTPUT: 06:54:54 INFO - 2015-12-18 06:54:54,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45015/tests/kraken/driver.html?testName=imaging-darkroom) 06:54:54 INFO - 2015-12-18 06:54:54,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 145657856 06:54:54 INFO - 2015-12-18 06:54:54,879 DEBUG : BROWSER_OUTPUT: 06:54:58 INFO - 2015-12-18 06:54:58,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45015/tests/kraken/driver.html?testName=imaging-desaturate) 06:54:58 INFO - 2015-12-18 06:54:58,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 145420288 06:54:58 INFO - 2015-12-18 06:54:58,949 DEBUG : BROWSER_OUTPUT: 06:55:01 INFO - 2015-12-18 06:55:01,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45015/tests/kraken/driver.html?testName=json-parse-financial) 06:55:02 INFO - 2015-12-18 06:55:02,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 145297408 06:55:02 INFO - 2015-12-18 06:55:02,478 DEBUG : BROWSER_OUTPUT: 06:55:04 INFO - 2015-12-18 06:55:04,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:04 INFO - 2015-12-18 06:55:04,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 148021248 06:55:04 INFO - 2015-12-18 06:55:04,818 DEBUG : BROWSER_OUTPUT: 06:55:06 INFO - 2015-12-18 06:55:06,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45015/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:55:07 INFO - 2015-12-18 06:55:07,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 148500480 06:55:07 INFO - 2015-12-18 06:55:07,316 DEBUG : BROWSER_OUTPUT: 06:55:09 INFO - 2015-12-18 06:55:09,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:55:10 INFO - 2015-12-18 06:55:10,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 148643840 06:55:10 INFO - 2015-12-18 06:55:10,047 DEBUG : BROWSER_OUTPUT: 06:55:12 INFO - 2015-12-18 06:55:12,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:55:13 INFO - 2015-12-18 06:55:13,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 149024768 06:55:13 INFO - 2015-12-18 06:55:13,226 DEBUG : BROWSER_OUTPUT: 06:55:15 INFO - 2015-12-18 06:55:15,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:55:16 INFO - 2015-12-18 06:55:16,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 148213760 06:55:16 INFO - 2015-12-18 06:55:16,436 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45015/tests/kraken/driver.html?testName=ai-astar) 06:55:18 INFO - 2015-12-18 06:55:18,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 148881408 06:55:18 INFO - 2015-12-18 06:55:18,481 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,482 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:55:18 INFO - 2015-12-18 06:55:18,484 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:55:18 INFO - 2015-12-18 06:55:18,484 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:55:18 INFO - 2015-12-18 06:55:18,484 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:55:18 INFO - 2015-12-18 06:55:18,484 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;110;112;114;114;125;112;114;114;114 06:55:18 INFO - 2015-12-18 06:55:18,484 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;134;159;185;139;161;155;134;167;130 06:55:18 INFO - 2015-12-18 06:55:18,484 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;164;162;165;171;163;164;167 06:55:18 INFO - 2015-12-18 06:55:18,484 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;75;73;74;73;141;73;71;73 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;137;95;95;96;135;95;95;132 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;112;110;110;113;113;110;110;110 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;149;147;148;148;148;148;147 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;99;96;96;97;96;96;96;95;96 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;76;74;73;73;73;73;75;70;71 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;73;68;75;68;67;68;68;67 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;93;84;91;82;85;83;85;85 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;125;127;136;121;125;128;123;125;131 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;147;153;153;152;151;148;150;144;139 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;79;71;71;72;72;70;70;72 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:55:18 INFO - 2015-12-18 06:55:18,485 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,801 06:55:18 INFO - 2015-12-18 06:55:18,486 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:55:18 INFO - 2015-12-18 06:55:18,486 DEBUG : BROWSER_OUTPUT: __startTimestamp1450450518482__endTimestamp 06:55:18 INFO - 2015-12-18 06:55:18,486 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:4.02 (3.5%) stddev-sans-first:4.24 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 112.0 114.0 114.0 125.0 112.0 114.0 114.0 114.0 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.20 Median:158.50 stddev:17.61 (11.1%) stddev-sans-first:18.55 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: Values: 158.0 134.0 159.0 185.0 139.0 161.0 155.0 134.0 167.0 130.0 06:55:18 INFO - 2015-12-18 06:55:18,489 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.72 (1.7%) stddev-sans-first:2.88 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 164.0 162.0 165.0 171.0 163.0 164.0 167.0 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:73.00 stddev:21.50 (29.4%) stddev-sans-first:22.69 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 75.0 73.0 74.0 73.0 141.0 73.0 71.0 73.0 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:95.00 stddev:19.06 (20.1%) stddev-sans-first:19.79 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 137.0 95.0 95.0 96.0 135.0 95.0 95.0 132.0 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:110.00 stddev:1.42 (1.3%) stddev-sans-first:1.36 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 112.0 110.0 110.0 113.0 113.0 110.0 110.0 110.0 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:55:18 INFO - 2015-12-18 06:55:18,490 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 149.0 147.0 148.0 148.0 148.0 148.0 147.0 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.14 (1.2%) stddev-sans-first:1.12 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: Values: 95.0 99.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.20 Median:73.50 stddev:1.75 (2.4%) stddev-sans-first:1.83 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 74.0 73.0 73.0 73.0 73.0 75.0 70.0 71.0 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:68.00 stddev:2.71 (4.0%) stddev-sans-first:2.85 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 73.0 68.0 75.0 68.0 67.0 68.0 68.0 67.0 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:3.74 (4.4%) stddev-sans-first:3.77 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 93.0 84.0 91.0 82.0 85.0 83.0 85.0 85.0 06:55:18 INFO - 2015-12-18 06:55:18,491 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:126.00 stddev:4.27 (3.4%) stddev-sans-first:4.49 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 127.0 136.0 121.0 125.0 128.0 123.0 125.0 131.0 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:150.50 stddev:6.14 (4.1%) stddev-sans-first:4.67 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: Values: 135.0 147.0 153.0 153.0 152.0 151.0 148.0 150.0 144.0 139.0 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:2.58 (3.6%) stddev-sans-first:2.74 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 79.0 71.0 71.0 72.0 72.0 70.0 70.0 72.0 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:55:18 INFO - 2015-12-18 06:55:18,492 DEBUG : BROWSER_OUTPUT: 06:55:19 INFO - 2015-12-18 06:55:19,481 INFO : Browser exited with error code: 0 06:55:19 INFO - 2015-12-18 06:55:19,533 INFO : Completed test kraken (00:01:02) 06:55:19 INFO - 2015-12-18 06:55:19,533 INFO : Starting test v8_7 06:55:19 INFO - 2015-12-18 06:55:19,533 DEBUG : operating with platform_type : linux_ 06:55:19 INFO - 2015-12-18 06:55:19,533 INFO : Initialising browser for v8_7 test... 06:55:19 INFO - 2015-12-18 06:55:19,539 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHvlaqU/profile http://localhost:45015/getInfo.html 06:55:25 INFO - 2015-12-18 06:55:25,444 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:55:25 INFO - 2015-12-18 06:55:25,444 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:55:25 INFO - 2015-12-18 06:55:25,444 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:55:25 INFO - 2015-12-18 06:55:25,444 DEBUG : BROWSER_OUTPUT: __metrics 06:55:25 INFO - 2015-12-18 06:55:25,586 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] 06:55:26 INFO - 2015-12-18 06:55:26,869 INFO : Browser initialized. 06:55:26 INFO - 2015-12-18 06:55:26,870 INFO : Running cycle 1/1 for v8_7 test... 06:55:26 INFO - 2015-12-18 06:55:26,870 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHvlaqU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:55:38 INFO - 2015-12-18 06:55:38,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 150331392 06:55:38 INFO - 2015-12-18 06:55:38,817 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45015/tests/v8_7/run.html (next: http://localhost:45015/tests/v8_7/run.html) 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 145072128 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: |0;Richards;165.8374792703151 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.70102135561746 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5235.602094240838 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1067.2358591248667 06:56:00 INFO - 2015-12-18 06:56:00,483 DEBUG : BROWSER_OUTPUT: |5;Earley;717.8750897343862 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: |7;RegExp;26500 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: |8;Splay;595.1536643026004 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: __startTimestamp1450450560482__endTimestamp 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,484 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.84 Median:165.84 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: Values: 165.8 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.70 Median:185.70 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: Values: 185.7 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: Values: 278.2 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: Values: 5235.6 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,485 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,486 DEBUG : BROWSER_OUTPUT: Values: 1067.2 06:56:00 INFO - 2015-12-18 06:56:00,486 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,486 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.88 Median:717.88 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: Values: 717.9 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: Values: 12292.7 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: Values: 26500.0 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.15 Median:595.15 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,487 DEBUG : BROWSER_OUTPUT: Values: 595.2 06:56:00 INFO - 2015-12-18 06:56:00,488 DEBUG : BROWSER_OUTPUT: 06:56:00 INFO - 2015-12-18 06:56:00,488 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 06:56:00 INFO - 2015-12-18 06:56:00,488 DEBUG : BROWSER_OUTPUT: Values: 4850.2 06:56:00 INFO - 2015-12-18 06:56:00,488 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:56:00 INFO - 2015-12-18 06:56:00,488 DEBUG : BROWSER_OUTPUT: 06:56:01 INFO - 2015-12-18 06:56:01,681 INFO : Browser exited with error code: 0 06:56:01 INFO - 2015-12-18 06:56:01,698 INFO : Completed test v8_7 (00:00:42) 06:56:01 INFO - 2015-12-18 06:56:01,986 INFO : Completed test suite (00:20:20) 06:56:01 INFO - 2015-12-18 06:56:01,987 DEBUG : Working with test: dromaeo_css 06:56:01 INFO - 2015-12-18 06:56:01,987 DEBUG : Generating results file: dromaeo_css 06:56:01 INFO - 2015-12-18 06:56:01,988 DEBUG : Working with test: kraken 06:56:01 INFO - 2015-12-18 06:56:01,988 DEBUG : Generating results file: kraken 06:56:01 INFO - 2015-12-18 06:56:01,988 INFO : javascript benchmark 06:56:01 INFO - 2015-12-18 06:56:01,988 DEBUG : Working with test: v8_7 06:56:01 INFO - 2015-12-18 06:56:01,988 DEBUG : Generating results file: v8_7 06:56:01 INFO - 2015-12-18 06:56:01,989 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:02 INFO - 2015-12-18 06:56:02,064 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 06:56:02 INFO - 2015-12-18 06:56:02,064 DEBUG : process_Request line: dromaeo_css 6357.93 graph.html#tests=[[72,132,43]] 06:56:02 INFO - 2015-12-18 06:56:02,064 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:02 INFO - 2015-12-18 06:56:02,102 DEBUG : process_Request line: kraken 1545.90 graph.html#tests=[[232,132,43]] 06:56:02 INFO - 2015-12-18 06:56:02,102 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:56:02 INFO - 2015-12-18 06:56:02,213 DEBUG : process_Request line: v8_7 21310.04 graph.html#tests=[[230,132,43]] 06:56:02 INFO - 2015-12-18 06:56:02,214 INFO : javascript benchmark 06:56:02 INFO - 2015-12-18 06:56:02,218 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2671.9866400667993, 2699.2442116207467, 2730.6177135201074, 2742.794290428217, 2747.3955729739464, 4566.269396896497, 4692.835750748724, 4743.833965811197, 4744.881377965548, 4822.469528351879, 4601.493835678073, 4669.439667239927, 4727.645426593002, 4768.356271903292, 4770.880727981802, 4366.7816609169495, 4381.583749543788, 4406.162829062484, 4447.35513350564, 4457.732536047832, 4434.002349471375, 4442.067165895166, 4498.98772776126, 4511.59395654391, 4552.248878934972, 4210.115875666113, 4245.490541135053, 4307.138572285556, 4342.1966936116605, 4348.239058164809, 4437.0, 4444.622207112399, 4445.9110817783785, 4463.352813841975, 4474.82100715971, 4194.0, 4413.9117217655785, 4424.911501769947, 4457.108578284357, 4470.240059189913, 4501.234790085693, 4603.194440972817, 4607.792649330788, 4608.0, 4614.353990441341, 5108.463611320833, 5134.358205224347, 5145.3568303962, 5145.614078944094, 5156.097682905476, 4943.703377797344, 5112.182050871843, 5165.147750621143, 5174.974125129388, 5216.061109000379, 4625.213713668684, 4704.694194877322, 4716.669833111718, 4717.95282047182, 4770.7376094314795, 5209.791608335624, 5241.816536421207, 5245.580353571705, 5250.684958902478, 5289.920651190235, 4843.24929635907, 4891.657583969088, 4972.8756781080765, 5046.646734728607, 5090.261912022736, 5135.332406787168, 5142.280080788692, 5154.92267615986, 5162.9741851291255, 5169.638125331191, 5092.9745351273, 5115.2071428928575, 5117.462666420047, 5127.102757017507, 5177.352830896138, 4738.099761045391, 4898.4121905371585, 4902.240152776325, 4905.435874874435, 5079.339685840817, 4138.896527586774, 4210.894727631834, 4223.0, 4228.640565551901, 4258.850940217139, 3707.684846788053, 3712.6844218241754, 3714.5542534895985, 3742.2328422673286, 3748.737588368788, 4235.8093885775215, 4336.3278691802825, 4355.499117601453, 4372.497162826252, 4403.911921761547, 5163.509466600667, 5168.2764412982215, 5186.870328241749, 5192.45479224676, 5195.922061169085, 4426.380306757057, 4437.023854751949, 4440.33394990754, 4463.464384273908, 4496.100779844044, 4315.050688848449, 4459.554044595579, 4471.061077173765, 4546.477155127137, 4553.749543775058, 4874.4150701916, 4898.14282500561, 4905.877353066202, 4907.484714104968, 4937.407511098691, 5172.172452407597, 5183.0670479314085, 5197.974010130077, 5200.843974680765, 5240.371155461369, 4670.859874203779, 4775.5463230993, 4809.639277054305, 4927.876803079952, 4953.1579631463455, 5066.847994560169, 5076.314697515788, 5088.363954505687, 5108.361454818148, 5150.845474635767, 4923.8276660316715, 5151.330327057459, 5182.637215394886, 5184.0927837629015, 5202.73986300691, 4835.274708793709, 4924.0, 4936.234883593049, 4946.307516947558, 4950.975245123751, 4888.560029597354, 4891.828785992473, 4898.510148985073, 4908.705477671208, 4964.578010868972, 4709.317149013305, 4780.6414518911915, 4793.400824896888, 4860.878478038077, 4863.051704917507, 4938.975305123451, 5014.598832093497, 5035.723035233097, 5036.1942089267, 5074.822381216787, 4908.0, 4916.139675556835, 4926.556609905126, 4927.507249275044, 4992.525710057684], "unit": "score", "name": "dojo.html", "value": 4673.009795224959}, {"lowerIsBetter": false, "replicates": [535.8472835241956, 561.8369974153501, 581.8080033588916, 587.500624469201, 588.9869424589705, 26794.866025669868, 35323.82338088309, 35700.0, 35728.82135589325, 35792.46311305332, 40168.79915600418, 40346.0, 40560.0, 40687.59312406882, 40882.59117408825, 7751.6124193790365, 7932.20677932205, 7945.165757595427, 7948.403869709766, 7984.201579841998, 7784.727534536292, 7886.171951945049, 7927.28654421102, 7940.1265860755275, 7948.8410231795615, 7941.404394670394, 7989.32090772285, 8028.157043510435, 8044.155363686817, 8074.3136833369235, 7937.087234967966, 7940.1265860755275, 7952.920470795276, 8031.0, 8039.437239393244, 7856.528608283521, 7918.2477664621765, 7938.6427610757655, 7949.682012719484, 7987.041555013436, 36036.81981590101, 36136.096597585005, 36515.63484365176, 36697.449538256944, 36741.632583674356, 2915.620969274002, 2923.6199294091844, 3075.4617941860083, 3455.1362159460136, 3539.628339024417, 27807.165785026482, 28052.719472805216, 28127.0, 28387.432251355065, 28929.079212941422, 3301.7193538549254, 3541.097020259843, 3554.5023696682483, 3557.2529768748595, 3561.857525698969, 218385.0, 220445.0, 220742.0, 220773.0, 221201.0, 52918.47081529212, 54154.458455415726, 57701.71149144227, 57744.0, 58123.70938145367, 51560.0, 51712.0, 51721.0, 51766.74116629468, 51798.741006294724, 12814.615561533168, 12885.613431597067, 12913.160644558073, 12978.545750898862, 13123.868761312455, 10128.898711012944, 10147.543360548645, 10148.238882083873, 10166.694999150037, 10177.796444071226, 19731.40805775829, 20107.59784804296, 20147.496312592302, 20179.394618161186, 20206.191752330036, 7521.623918804147, 7790.883136752953, 7842.098158711707, 7852.254035866584, 7856.960715196387, 847.3179090831816, 884.6240347852266, 942.5098948546854, 959.031378307914, 1060.9522571484301, 26321.605175922377, 30321.0, 30515.69484305173, 30795.538066929013, 31755.52366714501, 989.4360214677565, 1012.8075665623508, 1023.0792286941663, 1050.5272627317738, 1063.574570171922, 13660.453581856615, 13704.24626645524, 13890.722185556233, 13932.164070155823, 14074.577762667137, 329554.0, 334618.0, 335017.0, 335708.0, 336016.0, 48387.0, 49162.508374916506, 49181.262281065814, 49349.25976110361, 49361.50638493641, 1219.0795949058404, 1226.7117227451542, 1237.07219585311, 1244.9813252801396, 1245.3710876007558, 26326.21021369362, 26544.070957516393, 26584.202473925812, 26615.866920665274, 27028.054018109273, 40978.38532421956, 41561.0, 41589.79205103955, 41663.583364167185, 41751.58248417477, 257656.0, 259452.0, 259522.0, 259535.0, 260681.0, 29876.85061574765, 42270.78864605657, 42634.18838131957, 43230.783846080565, 43863.0, 38021.619783801805, 38609.613903860605, 38947.02632434212, 39548.604513955645, 39789.0, 32211.295700994684, 33351.49972750459, 33394.666053339155, 33439.49840752439, 33955.4906676405, 33144.0, 33354.0, 33356.33287334191, 33649.49525757066, 33878.8306058478, 38001.0, 38183.618163818006, 38333.80833095816, 38885.41671874981, 39266.0, 29017.12948611545, 29888.70111298946, 30195.547066793577, 30252.5462118064, 30569.08292751221, 23345.639592895357, 23744.643830342906, 23754.524909501368, 23943.0, 23975.640365394185], "unit": "score", "name": "ext.html", "value": 17359.331658470313}, {"lowerIsBetter": false, "replicates": [324.1782082421062, 326.1259823672558, 328.0764647517238, 328.55972996185125, 333.8314151353566, 10179.287449878511, 10387.324823886442, 14775.704485910275, 15216.847831521682, 16264.512064638051, 15596.220188990534, 15801.762973555406, 15816.0, 16309.83690163098, 16710.415135470263, 5407.459254074581, 5567.359753628324, 5696.060150075254, 5735.225744524499, 5738.139279108146, 5674.659520428788, 5744.052231381817, 5759.539236861041, 5761.423857614247, 5765.135229715555, 5590.552755779528, 5665.716714164296, 6127.816165515042, 6327.968360158193, 6344.080108384282, 6253.6873156342, 6298.149749783766, 6304.968475157618, 6664.733410663568, 6670.7331706731675, 6363.172787537591, 6389.872202555923, 6393.904091438632, 6394.488440924715, 6395.616263024187, 20295.5940881183, 20719.792802071937, 21136.15455381783, 21153.048112834804, 21295.254666086767, 2009.1461129020108, 2010.105503051143, 2014.1741885826887, 2028.6652702304102, 2076.252549082329, 13673.453061877612, 13723.45106195751, 13868.791968120486, 14002.649933751636, 14013.719725605431, 1796.8562514998769, 1809.1225755508567, 1836.2403823677114, 1852.870299079065, 1871.0551171658226, 58429.415705842825, 62464.37535624631, 62611.37388626101, 62820.0, 64461.67769161171, 15014.774778378332, 15460.845391545941, 15472.845271547141, 15481.767773483407, 15517.844821551866, 23264.0, 23301.7669823303, 23557.057717691445, 23566.29301120969, 23589.882050589982, 8718.17177368149, 8742.25690816275, 8750.124987501198, 8764.298856091498, 8801.47191168532, 7324.853502929912, 7325.04774379338, 7359.889601655979, 7365.2634736525915, 7368.1526624438875, 7408.666610002563, 7475.8504829903095, 7497.137829149718, 7535.924640753632, 7594.620268986529, 1704.914754262282, 1742.8082910879793, 3059.005823107499, 3105.48759454692, 3145.0564830550743, 371.31307081898814, 377.3415390144161, 378.3832353264217, 784.1374488063085, 948.3977674176809, 9290.628374865066, 9298.070192980784, 9488.762780930532, 9580.281478889112, 9637.518124093907, 393.0664671405412, 394.9940750888739, 397.3979421176919, 408.244747217645, 408.65060373380925, 5162.870928226749, 5232.633715639945, 5262.368515778131, 5277.525022747971, 5362.1420572708175, 456895.0, 459616.0, 463860.0, 467220.0, 467982.0, 70154.0, 72738.63630681919, 72916.0, 73011.0, 73309.6334518324, 433.58159376202116, 434.6283927242226, 435.44915681662724, 436.2844934307738, 438.6622300828344, 8862.512561809162, 8991.595378208127, 9066.09339066088, 9183.678571249975, 9192.35653504275, 30622.387552248383, 30816.84591577028, 31007.0697879064, 31053.689463105078, 31670.366592668477, 45264.0, 45480.31779523243, 46393.30410043919, 47157.528424716686, 47327.29009064798, 8648.56757162152, 8850.822983540422, 8858.468491890508, 8867.467951922905, 8972.730818075468, 12397.814032789696, 12722.427490762753, 16459.67080658404, 16540.66918661644, 16552.503424897273, 12844.42200100979, 12882.09825312219, 12959.870401296244, 13213.933930330288, 13381.732365352444, 10362.948185259025, 13118.606441806762, 13249.13880597758, 13873.79189312141, 13916.721665566429, 13699.589012329647, 14218.511760442088, 14252.144871307755, 14489.203093829941, 14690.48583299622, 8717.825643487222, 8803.955980220058, 8910.777230569287, 8913.50975696317, 8934.597943092707, 11697.0, 13724.0, 13903.652408689864, 14132.081414708011, 14154.363053662404], "unit": "score", "name": "jquery.html", "value": 8330.389156340454}, {"lowerIsBetter": false, "replicates": [1479.5709244319148, 1666.4500714764129, 1716.562276619462, 1732.099308359653, 1757.6924038293296, 6154.415330543602, 6371.0, 6552.901706474401, 7069.858602827947, 7082.858342833147, 6647.6343801090925, 6734.764283250087, 6781.186257649077, 6798.45612351012, 6809.250982391933, 1966.5280332720115, 1999.1004048178306, 2008.0562135796151, 2008.3472871316808, 2008.3874418302412, 2030.7969203079722, 2051.3743308290964, 2058.6911963205566, 2080.2303147835246, 2085.551606404623, 2007.2874129683971, 2036.3178335257705, 2045.427280361501, 2061.4331058958755, 2063.432556047084, 1977.2486455147096, 1986.692062730279, 1999.6900480425484, 2001.2995451591971, 2002.6682256299543, 2015.334939469986, 2033.6339458897392, 2051.0770153431017, 2055.0238636647623, 2058.7750288578272, 7050.471214658921, 7079.185893622248, 7122.857542849114, 7140.321669441395, 7147.642617869085, 4110.321796903508, 4134.627883490471, 4149.294619914622, 4162.583741625813, 4173.061061261223, 2596.0, 2605.557055300603, 2637.9604305935427, 2661.055325359489, 2670.505956398053, 897.5736525150501, 915.3409545127497, 915.514777168102, 927.6938610258599, 930.2929773372218, 9449.811003779885, 9450.243980481546, 9451.385659932082, 9477.28920330978, 9490.525473726286, 3721.0697325668584, 3749.6625303722794, 3786.413105968524, 3789.621037896188, 3793.867214647474, 8090.271875531231, 8137.75586732399, 8138.023437187576, 8151.510909345339, 8160.224778646019, 4106.014556506417, 4124.030852749602, 4129.6489798367475, 4132.33882578786, 4141.503019637603, 3193.409219294438, 3224.661410551905, 3655.1775850433974, 3731.1045349116016, 3756.323861704919, 3377.919065898938, 3390.5592273004845, 3393.0, 3406.335764525894, 3459.757816952789, 1075.0861767497565, 1082.7494244148022, 1083.7940791249637, 1084.7017070305728, 1093.9726506837392, 885.3536918049859, 951.0442005784142, 1170.1750266062575, 1173.5833779008499, 1186.2941549777868, 6632.83417914556, 6642.4021838034805, 6654.201495820533, 6665.700043498055, 6688.4649228061635, 1027.6300531808542, 1028.9794204115876, 1050.0969166516788, 1051.6687243518268, 1054.0144964458257, 5381.192821076792, 5401.756920938567, 5414.8917021659345, 5434.3207099112615, 5451.04606693827, 8111.3916456266015, 8132.2680958714, 8321.875171872427, 8369.748907532783, 8414.747557573282, 8262.917370826215, 8320.502309584333, 8321.750347489586, 8322.042965058974, 8324.29243514296, 6349.555531112777, 6630.801075967825, 6786.76246331376, 6806.829829254309, 6818.18181818185, 6597.175353080865, 6674.132362792806, 6734.831629209309, 6736.461083113241, 6740.39336459721, 7660.846783064419, 7661.233876612294, 7683.462157648911, 7709.0, 7821.569813660303, 7771.067471903408, 7922.0, 7943.642536086006, 8016.959915200387, 8064.919350806417, 5114.74426278692, 5590.720463976866, 5691.8292451226525, 6040.637561746309, 6127.6936153193055, 6737.191537015589, 6744.460443164437, 6772.018057381751, 6776.661166941732, 6786.558873673195, 6333.398327158912, 6387.137736405526, 6457.515686323639, 6484.643344616092, 6501.772437964649, 6277.5605707600025, 6470.902936456051, 6483.837904052436, 6531.444827189552, 6588.110605068255, 6559.0817285579105, 6565.474762018932, 6580.5722628029025, 6618.8345291368105, 6634.170728658918, 6002.735273130848, 6042.063480160582, 6054.576179667381, 6060.212172417558, 6080.939190608037, 5956.434138756811, 5970.253718285215, 5991.071383935497, 5997.0, 5999.370066142992], "unit": "score", "name": "mootools.html", "value": 4063.0724247771695}, {"lowerIsBetter": false, "replicates": [300.3332601624394, 307.6277703978186, 308.6065266784849, 311.31665993145054, 311.50470751505117, 5531.502164805172, 5580.246666699994, 5605.243292155557, 5668.206451096849, 5791.913121303184, 5574.916376254359, 5601.60788744788, 5623.4938855503, 5640.351359593648, 5641.717914104299, 4151.813168407429, 4260.552641972579, 4321.092570560186, 4322.330038843984, 4322.84870029549, 4253.914921701564, 4267.530571637118, 4272.060146767706, 4283.20760659279, 4291.806868690916, 4228.048689044971, 4229.196452673982, 4231.64031057359, 4232.0054787125, 4232.76719780412, 4228.619424251817, 4230.386593943892, 4236.068065025689, 4241.448611680493, 4248.723832950879, 3616.8553257869653, 3672.559292884871, 3673.246984368198, 3673.742838001341, 3682.5396825396824, 5286.81496147633, 5394.487523685244, 5399.892002159974, 5431.782728690848, 5447.945520544784, 4901.338319326881, 4910.656254062217, 4919.606431485473, 4921.901561968776, 4928.1129396708575, 5930.1401296812155, 5932.762689492415, 5933.554983376221, 5937.584369094165, 5956.761729530857, 3915.647591716731, 4024.4566983457153, 4039.3738970459626, 4049.777262250575, 4051.534073581546, 6180.196574445338, 6226.066090086478, 6228.37716228378, 6243.157173781527, 6257.5932564383165, 4104.692148088846, 4121.649659778893, 4121.793910304473, 4124.587541245852, 4129.2773764591075, 4183.6234738873645, 4188.497380314382, 4188.748675079505, 4191.266528357525, 4192.601702838226, 4766.809327626856, 4792.496787837296, 4842.201036828884, 4849.854504364875, 4862.975685121552, 5843.970780146072, 5908.556858235649, 5916.26046744157, 5921.230240068763, 5926.259217597801, 1448.9058211216238, 1482.1847983608973, 1482.3403585404392, 1487.0259979713305, 1488.1666266890577, 985.6796541124163, 994.0012027414518, 1006.3207335048959, 1009.7677534167183, 1011.7672935224792, 5110.897782044338, 5118.0, 5121.257417674491, 5121.948780512147, 5122.308488354099, 6141.232345956755, 6144.8771024580155, 6161.476274516626, 6168.136460895478, 6177.413145751147, 5034.748262586856, 5034.84895453137, 5059.19052951526, 5064.696118232918, 5107.693538387709, 3231.4829627259523, 3270.9509357359657, 3289.3914625794305, 3331.217163966466, 3332.5334453176574, 5833.0, 5846.473817356373, 5850.151727999416, 5852.590318677737, 5865.178874957509, 6355.1420558224045, 6384.106225128486, 6409.8718025640155, 6416.197975253093, 6420.486361091102, 5657.773689052474, 5823.7670493181495, 5834.445727655866, 5838.036723940587, 5846.41535846412, 6186.721597528212, 6194.163787888578, 6199.5970261934635, 6199.907001394892, 6219.875602488016, 6032.54755893301, 6057.939420605738, 6065.393460654076, 6067.059605761114, 6070.392960704071, 5694.800681976111, 5820.417958204315, 5820.738066787089, 5821.214136091573, 5825.271841019872, 4109.075458021921, 4142.109446469024, 4142.502899652061, 4143.709940304149, 4145.66834653221, 5914.3198532167635, 6093.36019717941, 6155.015197568547, 6169.938300616936, 6192.473639740492, 5838.970805145947, 5892.7642894283745, 5920.526357891445, 5937.4656280933195, 5955.464008239279, 5907.232059832194, 5912.231409916683, 5920.674362910081, 5929.52563794904, 5937.109433584997, 5671.6597004179885, 5777.7977770777825, 5795.188673585786, 5795.188673585786, 5810.302763668386, 5966.19456373384, 5983.311919129356, 5988.401159883977, 5989.760409583568, 5993.400659933972, 5827.329857066492, 5828.970855145697, 5833.491598612637, 5838.416158384128, 5839.532837373085], "unit": "score", "name": "prototype.html", "value": 4401.964732381732}, {"lowerIsBetter": false, "replicates": [596.5853731656498, 661.6724721262975, 696.143743195869, 714.2179313651551, 728.4718579030204, 10978.231523793327, 11344.262622929504, 11369.715757106067, 11383.487743051563, 11389.544418223282, 13322.600321990332, 13470.461181552726, 13530.458781648747, 13546.729065418685, 13560.796588051187, 784.701813310941, 787.1184273613546, 799.6801279488193, 802.7631848604676, 803.0844836885955, 793.0919097633207, 793.3811626931004, 802.3541049455187, 804.8148925747082, 806.5644551941945, 819.942604017719, 824.3693574415577, 829.8713699376606, 831.3723139030024, 831.9916800831975, 818.7175424478545, 820.6430202861774, 821.6631181215703, 821.8972628421448, 824.3405275779412, 609.704293417692, 613.2120225510198, 613.5214532664529, 613.9693015349214, 614.5053232148119, 11412.942935285271, 11566.595169169039, 11640.94179529097, 11656.41717914101, 11663.183577149603, 10216.284860059799, 10787.298825576312, 11028.558857645685, 11094.667159985212, 11410.600628978029, 8821.42660727057, 9007.324450666161, 9149.862752058725, 9342.0, 9607.279454040974, 3213.967860321414, 3224.2423030587793, 3256.2022304535303, 3256.6417694053634, 3304.0913748719054, 40381.0, 40387.798061009504, 40396.19207615861, 40585.0, 40726.18547629031, 8056.152270569969, 8121.75634730959, 8490.232497921004, 8501.787455313543, 8667.393282470166, 14810.778383242385, 14826.0, 14826.777598336033, 14847.40610375573, 14986.325615347336, 6038.939610603926, 6063.484128967758, 6141.539384546088, 6152.477039451607, 6283.874322513524, 3487.3548393547276, 3527.700145487611, 3545.3618348697482, 3574.410222313289, 3635.4546817977516, 2457.054034196847, 2457.348802567321, 2463.1625247415964, 2464.0636558108163, 2586.4439145583788, 478.3160081084014, 482.6114977443122, 484.08507920031167, 485.434468843793, 495.22250067393844, 437.1061179887075, 439.10641843847617, 439.59118020240845, 446.3193629714711, 456.4841728846382, 6775.4240889524945, 6888.311168883171, 6889.237981495913, 6923.273056329113, 7061.9293807062295, 518.8786675512714, 525.9631825772236, 539.719345940109, 545.7625932719279, 554.1075585443976, 3299.686529779667, 3308.8180150091976, 3310.652381499956, 3383.120388698956, 3426.1605906553054, 45611.77194114008, 47020.529794701615, 48520.27219591709, 48750.756246218545, 48911.75544122328, 37913.81043094822, 37947.43078853819, 38212.0, 38288.23423531514, 38687.61312386896, 38662.22675546473, 40044.194696636005, 40748.99999999941, 40872.56946006935, 41198.1760364797, 7129.39400150993, 7150.956382235908, 7193.604351760703, 7268.96365518169, 7415.184329723834, 31477.0, 31606.209844753146, 31938.76940862303, 32428.189295267806, 32459.837700811346, 36012.0, 36376.27247455089, 38447.615523844404, 39853.80073099616, 39959.0, 9306.836645419322, 9380.155785979294, 9714.902850971683, 9732.513374331396, 9813.01869813013, 10275.332103413255, 10281.434521101412, 10575.471226438802, 10587.894121058998, 11208.887911120784, 9848.057683191595, 9873.605055797687, 9920.0, 9977.850332245167, 10019.0, 9252.352335336462, 9263.907360926305, 9394.248460123037, 9591.088846559845, 9591.28065395112, 9917.206623469961, 10019.198464122706, 10051.69844904654, 10056.944020877703, 10169.389836609827, 8693.34799889998, 8747.03782583928, 8911.643534258557, 9185.127412895765, 9230.723078307661, 8068.838623227385, 8240.423170378255, 8280.71017514384, 8661.13388661129, 8916.108389161032], "unit": "score", "name": "yui.html", "value": 5464.538746816072}], "name": "dromaeo_css", "value": 6357.931011276196}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 112.0, 114.0, 114.0, 125.0, 112.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 159.0, 185.0, 139.0, 161.0, 155.0, 134.0, 167.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 164.0, 162.0, 165.0, 171.0, 163.0, 164.0, 167.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 75.0, 73.0, 74.0, 73.0, 141.0, 73.0, 71.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 137.0, 95.0, 95.0, 96.0, 135.0, 95.0, 95.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 112.0, 110.0, 110.0, 113.0, 113.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.7}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 149.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [95.0, 99.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 74.0, 73.0, 73.0, 73.0, 73.0, 75.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 73.0, 68.0, 75.0, 68.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 93.0, 84.0, 91.0, 82.0, 85.0, 83.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 127.0, 136.0, 121.0, 125.0, 128.0, 123.0, 125.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [135.0, 147.0, 153.0, 153.0, 152.0, 151.0, 148.0, 150.0, 144.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 79.0, 71.0, 71.0, 72.0, 72.0, 70.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1545.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8374792703151], "unit": "score", "name": "Richards", "value": 212.87106}, {"lowerIsBetter": false, "replicates": [185.70102135561746], "unit": "score", "name": "DeltaBlue", "value": 356.04543000000007}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [717.8750897343862], "unit": "score", "name": "Earley", "value": 928.3829590000004}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [595.1536643026004], "unit": "score", "name": "Splay", "value": 136.92430188679248}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21310.036074775944}]} 06:56:02 INFO - RETURN: dromaeo_css: 6357.93 06:56:02 INFO - RETURN: kraken: 1545.90 06:56:02 INFO - RETURN: v8_7: 21310.04 06:56:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21310.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1545.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6357.93"}}} 06:56:02 INFO - Return code: 0 06:56:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:56:02 INFO - # TBPL SUCCESS # 06:56:02 INFO - Running post-action listener: _resource_record_post_action 06:56:02 INFO - Running post-run listener: _resource_record_post_run 06:56:03 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542568448; Read time: 12; Write time: 1110868 06:56:03 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 227622912; Read time: 0; Write time: 712840 06:56:03 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314888192; Read time: 12; Write time: 398004 06:56:03 INFO - Running post-run listener: _upload_blobber_files 06:56:03 INFO - Blob upload gear active. 06:56:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:56:03 INFO - Copying logs to upload dir... 06:56:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.971610 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-18 06:56:02.827737) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 06:56:02.831987) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010088 build_url: 'https://queue.taskcluster.net/v1/task/CdGSfWOuTuiRjFpB4VUnJw/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-18 06:56:02.883356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:56:02.883693) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450449116.606600-502022781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 06:56:02.933108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 06:56:02.933432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 06:56:02.933711) ========= ========= Total master_lag: 0.30 =========