builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1453244558.52 results: success (0) buildid: 20160119140132 builduid: b74782cec507467ca4dd3e6162cf9902 revision: 29e2798d08b4fdf50254234dfe6424ca8229b5a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.516313) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.516683) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.516953) ========= 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=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006349 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.545795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.546106) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.570779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.571063) ========= 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=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.635959) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.636215) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.636573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.636839) ========= 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=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 15:02:39-- 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% 225M=0s 2016-01-19 15:02:39 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.815264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.815583) ========= 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=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017248 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:38.898456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 15:02:38.898786) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29e2798d08b4fdf50254234dfe6424ca8229b5a0 --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 29e2798d08b4fdf50254234dfe6424ca8229b5a0 --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=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 15:02:39,775 truncating revision to first 12 chars 2016-01-19 15:02:39,775 Setting DEBUG logging. 2016-01-19 15:02:39,775 attempt 1/10 2016-01-19 15:02:39,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29e2798d08b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 15:02:40,553 unpacking tar archive at: fx-team-29e2798d08b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.077563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 15:02:39.989322) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:39.989655) ========= echo '%(revision)s' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004868 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:40.040100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:40.040437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:40.051471) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:40.051750) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 15:02:40.052159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-19 15:02:40.052491) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:02:41 INFO - MultiFileLogger online at 20160119 15:02:41 in /builds/slave/test 15:02:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:02:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:02:41 INFO - {'append_to_log': False, 15:02:41 INFO - 'base_work_dir': '/builds/slave/test', 15:02:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:02:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:02:41 INFO - 'branch': 'Fx-Team-Non-PGO', 15:02:41 INFO - 'buildbot_json_path': 'buildprops.json', 15:02:41 INFO - 'config_files': ('talos/linux_config.py',), 15:02:41 INFO - 'default_actions': ('clobber', 15:02:41 INFO - 'read-buildbot-config', 15:02:41 INFO - 'download-and-extract', 15:02:41 INFO - 'populate-webroot', 15:02:41 INFO - 'create-virtualenv', 15:02:41 INFO - 'install', 15:02:41 INFO - 'run-tests'), 15:02:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:02:41 INFO - 'download_minidump_stackwalk': True, 15:02:41 INFO - 'download_symbols': 'ondemand', 15:02:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:02:41 INFO - 'tooltool.py': '/tools/tooltool.py', 15:02:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:02:41 INFO - '/tools/misc-python/virtualenv.py')}, 15:02:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:02:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:02:41 INFO - 'installer_path': 'installer.exe', 15:02:41 INFO - 'log_level': 'info', 15:02:41 INFO - 'log_name': 'talos', 15:02:41 INFO - 'log_to_console': True, 15:02:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:02:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:02:41 INFO - 'opt_config_files': (), 15:02:41 INFO - 'pip_index': False, 15:02:41 INFO - 'sps_profile': False, 15:02:41 INFO - 'sps_profile_interval': 0, 15:02:41 INFO - 'suite': 'dromaeojs-e10s', 15:02:41 INFO - 'system_bits': '32', 15:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:02:41 INFO - 'title': 'talos-linux64-ix-008', 15:02:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:02:41 INFO - 'use_talos_json': True, 15:02:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:02:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:02:41 INFO - 'work_dir': 'build'} 15:02:41 INFO - ##### 15:02:41 INFO - ##### Running clobber step. 15:02:41 INFO - ##### 15:02:41 INFO - Running pre-action listener: _resource_record_pre_action 15:02:41 INFO - Running main action method: clobber 15:02:41 INFO - rmtree: /builds/slave/test/build 15:02:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:02:41 INFO - Running post-action listener: _resource_record_post_action 15:02:41 INFO - ##### 15:02:41 INFO - ##### Running read-buildbot-config step. 15:02:41 INFO - ##### 15:02:41 INFO - Running pre-action listener: _resource_record_pre_action 15:02:41 INFO - Running main action method: read_buildbot_config 15:02:41 INFO - Using buildbot properties: 15:02:41 INFO - { 15:02:41 INFO - "project": "", 15:02:41 INFO - "product": "firefox", 15:02:41 INFO - "script_repo_revision": "production", 15:02:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:02:41 INFO - "repository": "", 15:02:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:02:41 INFO - "buildid": "20160119140132", 15:02:41 INFO - "pgo_build": "False", 15:02:41 INFO - "basedir": "/builds/slave/test", 15:02:41 INFO - "buildnumber": 972, 15:02:41 INFO - "slavename": "talos-linux64-ix-008", 15:02:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:02:41 INFO - "platform": "ubuntu64_hw", 15:02:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:02:41 INFO - "branch": "fx-team", 15:02:41 INFO - "repo_path": "integration/fx-team", 15:02:41 INFO - "revision": "29e2798d08b4fdf50254234dfe6424ca8229b5a0", 15:02:41 INFO - "stage_platform": "linux64", 15:02:41 INFO - "builduid": "b74782cec507467ca4dd3e6162cf9902", 15:02:41 INFO - "slavebuilddir": "test" 15:02:41 INFO - } 15:02:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:02:41 INFO - Running post-action listener: _resource_record_post_action 15:02:41 INFO - ##### 15:02:41 INFO - ##### Running download-and-extract step. 15:02:41 INFO - ##### 15:02:41 INFO - Running pre-action listener: _resource_record_pre_action 15:02:41 INFO - Running main action method: download_and_extract 15:02:41 INFO - mkdir: /builds/slave/test/build/tests 15:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:41 INFO - https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/test_packages.json 15:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/test_packages.json 15:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:02:43 INFO - Downloaded 1448 bytes. 15:02:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:02:43 INFO - Using the following test package requirements: 15:02:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:02:43 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:02:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:43 INFO - u'jsshell-linux-x86_64.zip'], 15:02:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:02:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:02:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:02:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:02:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:02:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:43 INFO - https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/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 15:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/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 15:02:51 INFO - Downloaded 21217439 bytes. 15:02:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:02:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:02:52 INFO - Return code: 0 15:02:52 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 15:02:52 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')]} 15:02:52 INFO - https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:02:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:02:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/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 15:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/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 15:02:54 INFO - Downloaded 21217439 bytes. 15:02:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:02:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:02:55 INFO - Return code: 0 15:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:55 INFO - https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:02:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/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 15:02:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/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 15:02:56 INFO - Downloaded 11132144 bytes. 15:02:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:02:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:02:56 INFO - Return code: 0 15:02: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')]} 15:02:56 INFO - https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:02:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:02:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:02:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/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 15:02:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/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 15:02:58 INFO - Downloaded 54190017 bytes. 15:02:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:02:58 INFO - mkdir: /builds/slave/test/properties 15:02:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:02:58 INFO - Writing to file /builds/slave/test/properties/build_url 15:02:58 INFO - Contents: 15:02:58 INFO - build_url:https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:02:58 INFO - Running post-action listener: _resource_record_post_action 15:02:58 INFO - Running post-action listener: set_extra_try_arguments 15:02:58 INFO - ##### 15:02:58 INFO - ##### Running populate-webroot step. 15:02:58 INFO - ##### 15:02:58 INFO - Running pre-action listener: _resource_record_pre_action 15:02:58 INFO - Running main action method: populate_webroot 15:02:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:02:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:02:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:02:58 INFO - '--tppagecycles', 15:02:58 INFO - '7'], 15:02:58 INFO - 'tests': ['tsvgm']}}, 15:02:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:02:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:02:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:02:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:02:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:58 INFO - 'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:58 INFO - 'tests': ['damp', 'tps']}, 15:02:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:58 INFO - 'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['damp', 'tps']}, 15:02:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:02:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:02:58 INFO - 'other': {'tests': ['a11yr', 15:02:58 INFO - 'ts_paint', 15:02:58 INFO - 'tpaint', 15:02:58 INFO - 'sessionrestore', 15:02:58 INFO - 'sessionrestore_no_auto_restore']}, 15:02:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['a11yr', 15:02:58 INFO - 'ts_paint', 15:02:58 INFO - 'tpaint', 15:02:58 INFO - 'sessionrestore', 15:02:58 INFO - 'sessionrestore_no_auto_restore']}, 15:02:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['a11yr', 15:02:58 INFO - 'ts_paint', 15:02:58 INFO - 'tpaint', 15:02:58 INFO - 'sessionrestore', 15:02:58 INFO - 'sessionrestore_no_auto_restore']}, 15:02:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['a11yr', 15:02:58 INFO - 'ts_paint', 15:02:58 INFO - 'tpaint', 15:02:58 INFO - 'sessionrestore', 15:02:58 INFO - 'sessionrestore_no_auto_restore']}, 15:02:58 INFO - 'other_l64': {'tests': ['a11yr', 15:02:58 INFO - 'ts_paint', 15:02:58 INFO - 'tpaint', 15:02:58 INFO - 'sessionrestore', 15:02:58 INFO - 'sessionrestore_no_auto_restore']}, 15:02:58 INFO - 'other_nol64': {'tests': ['a11yr', 15:02:58 INFO - 'ts_paint', 15:02:58 INFO - 'tpaint', 15:02:58 INFO - 'sessionrestore', 15:02:58 INFO - 'sessionrestore_no_auto_restore']}, 15:02:58 INFO - 'svgr': {'tests': ['tsvgx', 15:02:58 INFO - 'tsvgr_opacity', 15:02:58 INFO - 'tart', 15:02:58 INFO - 'tscrollx', 15:02:58 INFO - 'cart']}, 15:02:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['tsvgx', 15:02:58 INFO - 'tsvgr_opacity', 15:02:58 INFO - 'tart', 15:02:58 INFO - 'tscrollx', 15:02:58 INFO - 'cart']}, 15:02:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:58 INFO - 'tests': ['tp5o']}, 15:02:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:58 INFO - 'talos_options': ['--e10s'], 15:02:58 INFO - 'tests': ['tp5o']}, 15:02:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:58 INFO - 'talos_options': ['--xperf_path', 15:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:58 INFO - 'tests': ['tp5n']}, 15:02:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:58 INFO - 'talos_options': ['--e10s', 15:02:58 INFO - '--xperf_path', 15:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:58 INFO - 'tests': ['tp5n']}}, 15:02:58 INFO - 'talos.zip': {'path': '', 15:02:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:02:58 INFO - Running post-action listener: _resource_record_post_action 15:02:58 INFO - ##### 15:02:58 INFO - ##### Running create-virtualenv step. 15:02:58 INFO - ##### 15:02:58 INFO - Running pre-action listener: _resource_record_pre_action 15:02:58 INFO - Running main action method: create_virtualenv 15:02:58 INFO - Creating virtualenv /builds/slave/test/build/venv 15:02:58 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 15:02:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:02:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:02:58 INFO - Using real prefix '/usr' 15:02:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:02:59 INFO - Installing distribute.............................................................................................................................................................................................done. 15:03:00 INFO - Installing pip.................done. 15:03:00 INFO - Return code: 0 15:03:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:03:00 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')]} 15:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:00 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')]} 15:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:00 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 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03:00 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 15:03:00 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 15:03:00 INFO - Using env: {'DISPLAY': ':0', 15:03:00 INFO - 'HOME': '/home/cltbld', 15:03:00 INFO - 'LANG': 'en_US.UTF-8', 15:03:00 INFO - 'LANGUAGE': 'en_US:en', 15:03:00 INFO - 'LOGNAME': 'cltbld', 15:03:00 INFO - 'MAIL': '/var/mail/cltbld', 15:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:00 INFO - 'MOZ_NO_REMOTE': '1', 15:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:00 INFO - 'NO_EM_RESTART': '1', 15:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:00 INFO - 'PWD': '/builds/slave/test', 15:03:00 INFO - 'SHELL': '/bin/bash', 15:03:00 INFO - 'SHLVL': '1', 15:03:00 INFO - 'TERM': 'linux', 15:03:00 INFO - 'TMOUT': '86400', 15:03:00 INFO - 'USER': 'cltbld', 15:03:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:00 INFO - '_': '/tools/buildbot/bin/python'} 15:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:01 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 15:03:01 INFO - Cleaning up... 15:03:01 INFO - Return code: 0 15:03:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:03:01 INFO - Using env: {'DISPLAY': ':0', 15:03:01 INFO - 'HOME': '/home/cltbld', 15:03:01 INFO - 'LANG': 'en_US.UTF-8', 15:03:01 INFO - 'LANGUAGE': 'en_US:en', 15:03:01 INFO - 'LOGNAME': 'cltbld', 15:03:01 INFO - 'MAIL': '/var/mail/cltbld', 15:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:01 INFO - 'MOZ_NO_REMOTE': '1', 15:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:01 INFO - 'NO_EM_RESTART': '1', 15:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:01 INFO - 'PWD': '/builds/slave/test', 15:03:01 INFO - 'SHELL': '/bin/bash', 15:03:01 INFO - 'SHLVL': '1', 15:03:01 INFO - 'TERM': 'linux', 15:03:01 INFO - 'TMOUT': '86400', 15:03:01 INFO - 'USER': 'cltbld', 15:03:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:01 INFO - '_': '/tools/buildbot/bin/python'} 15:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:01 INFO - Downloading/unpacking psutil>=0.7.1 15:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:03:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:03 INFO - Installing collected packages: psutil 15:03:03 INFO - Running setup.py install for psutil 15:03:03 INFO - building 'psutil._psutil_linux' extension 15:03:03 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 15:03:03 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 15:03:03 INFO - building 'psutil._psutil_posix' extension 15:03:03 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 15:03:03 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 15:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:03 INFO - Successfully installed psutil 15:03:03 INFO - Cleaning up... 15:03:03 INFO - Return code: 0 15:03:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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', '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 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:03: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 mozsystemmonitor==0.0.0 15:03:03 INFO - Using env: {'DISPLAY': ':0', 15:03:03 INFO - 'HOME': '/home/cltbld', 15:03:03 INFO - 'LANG': 'en_US.UTF-8', 15:03:03 INFO - 'LANGUAGE': 'en_US:en', 15:03:03 INFO - 'LOGNAME': 'cltbld', 15:03:03 INFO - 'MAIL': '/var/mail/cltbld', 15:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:03 INFO - 'MOZ_NO_REMOTE': '1', 15:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:03 INFO - 'NO_EM_RESTART': '1', 15:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:03 INFO - 'PWD': '/builds/slave/test', 15:03:03 INFO - 'SHELL': '/bin/bash', 15:03:03 INFO - 'SHLVL': '1', 15:03:03 INFO - 'TERM': 'linux', 15:03:03 INFO - 'TMOUT': '86400', 15:03:03 INFO - 'USER': 'cltbld', 15:03:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:03 INFO - '_': '/tools/buildbot/bin/python'} 15:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:03:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:03:05 INFO - Installing collected packages: mozsystemmonitor 15:03:05 INFO - Running setup.py install for mozsystemmonitor 15:03:05 INFO - Successfully installed mozsystemmonitor 15:03:05 INFO - Cleaning up... 15:03:05 INFO - Return code: 0 15:03:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:03:05 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')]} 15:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:05 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')]} 15:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:05 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 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03:05 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 15:03:05 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 15:03:05 INFO - Using env: {'DISPLAY': ':0', 15:03:05 INFO - 'HOME': '/home/cltbld', 15:03:05 INFO - 'LANG': 'en_US.UTF-8', 15:03:05 INFO - 'LANGUAGE': 'en_US:en', 15:03:05 INFO - 'LOGNAME': 'cltbld', 15:03:05 INFO - 'MAIL': '/var/mail/cltbld', 15:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:05 INFO - 'MOZ_NO_REMOTE': '1', 15:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:05 INFO - 'NO_EM_RESTART': '1', 15:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:05 INFO - 'PWD': '/builds/slave/test', 15:03:05 INFO - 'SHELL': '/bin/bash', 15:03:05 INFO - 'SHLVL': '1', 15:03:05 INFO - 'TERM': 'linux', 15:03:05 INFO - 'TMOUT': '86400', 15:03:05 INFO - 'USER': 'cltbld', 15:03:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:05 INFO - '_': '/tools/buildbot/bin/python'} 15:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:06 INFO - Downloading/unpacking blobuploader==1.2.4 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:03:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:03:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:03:07 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 15:03:07 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 15:03:07 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 15:03:07 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 15:03:07 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 15:03:07 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 15:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:03:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:08 INFO - Downloading docopt-0.6.1.tar.gz 15:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:03:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:03:08 INFO - Running setup.py install for blobuploader 15:03:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:03:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:03:08 INFO - Running setup.py install for requests 15:03:08 INFO - Running setup.py install for docopt 15:03:09 INFO - Successfully installed blobuploader requests docopt 15:03:09 INFO - Cleaning up... 15:03:09 INFO - Return code: 0 15:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:09 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 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03:09 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 15:03:09 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 15:03:09 INFO - Using env: {'DISPLAY': ':0', 15:03:09 INFO - 'HOME': '/home/cltbld', 15:03:09 INFO - 'LANG': 'en_US.UTF-8', 15:03:09 INFO - 'LANGUAGE': 'en_US:en', 15:03:09 INFO - 'LOGNAME': 'cltbld', 15:03:09 INFO - 'MAIL': '/var/mail/cltbld', 15:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:09 INFO - 'MOZ_NO_REMOTE': '1', 15:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:09 INFO - 'NO_EM_RESTART': '1', 15:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:09 INFO - 'PWD': '/builds/slave/test', 15:03:09 INFO - 'SHELL': '/bin/bash', 15:03:09 INFO - 'SHLVL': '1', 15:03:09 INFO - 'TERM': 'linux', 15:03:09 INFO - 'TMOUT': '86400', 15:03:09 INFO - 'USER': 'cltbld', 15:03:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:09 INFO - '_': '/tools/buildbot/bin/python'} 15:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:09 INFO - Running setup.py (path:/tmp/pip-gtOYAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:09 INFO - Running setup.py (path:/tmp/pip-Xtfoug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:09 INFO - Running setup.py (path:/tmp/pip-TZC4PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:09 INFO - Running setup.py (path:/tmp/pip-liVY1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:09 INFO - Running setup.py (path:/tmp/pip-faPJk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:09 INFO - Running setup.py (path:/tmp/pip-hJDASs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:09 INFO - Running setup.py (path:/tmp/pip-pQvywc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:09 INFO - Running setup.py (path:/tmp/pip-g68bwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:09 INFO - Running setup.py (path:/tmp/pip-jHEiDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:09 INFO - Running setup.py (path:/tmp/pip-6BoC1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:10 INFO - Running setup.py (path:/tmp/pip-n_m5Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:10 INFO - Running setup.py (path:/tmp/pip-LIgB6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:10 INFO - Running setup.py (path:/tmp/pip-aEAWOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:10 INFO - Running setup.py (path:/tmp/pip-i6C7Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:10 INFO - Running setup.py (path:/tmp/pip-m8CB1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:10 INFO - Running setup.py (path:/tmp/pip-tSpE2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:10 INFO - Running setup.py (path:/tmp/pip-iOgCCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:03:10 INFO - Running setup.py install for manifestparser 15:03:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:03:10 INFO - Running setup.py install for mozcrash 15:03:10 INFO - Running setup.py install for mozdebug 15:03:10 INFO - Running setup.py install for mozdevice 15:03:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:03:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:03:10 INFO - Running setup.py install for mozfile 15:03:11 INFO - Running setup.py install for mozhttpd 15:03:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Running setup.py install for mozinfo 15:03:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Running setup.py install for mozInstall 15:03:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Running setup.py install for mozleak 15:03:11 INFO - Running setup.py install for mozlog 15:03:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Running setup.py install for moznetwork 15:03:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Running setup.py install for mozprocess 15:03:11 INFO - Running setup.py install for mozprofile 15:03:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:03:11 INFO - Running setup.py install for mozrunner 15:03:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:03:12 INFO - Running setup.py install for mozscreenshot 15:03:12 INFO - Running setup.py install for moztest 15:03:12 INFO - Running setup.py install for mozversion 15:03:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:03:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:03:12 INFO - Cleaning up... 15:03:12 INFO - Return code: 0 15:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:12 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 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03:12 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 15:03:12 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 15:03:12 INFO - Using env: {'DISPLAY': ':0', 15:03:12 INFO - 'HOME': '/home/cltbld', 15:03:12 INFO - 'LANG': 'en_US.UTF-8', 15:03:12 INFO - 'LANGUAGE': 'en_US:en', 15:03:12 INFO - 'LOGNAME': 'cltbld', 15:03:12 INFO - 'MAIL': '/var/mail/cltbld', 15:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:12 INFO - 'MOZ_NO_REMOTE': '1', 15:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:12 INFO - 'NO_EM_RESTART': '1', 15:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:12 INFO - 'PWD': '/builds/slave/test', 15:03:12 INFO - 'SHELL': '/bin/bash', 15:03:12 INFO - 'SHLVL': '1', 15:03:12 INFO - 'TERM': 'linux', 15:03:12 INFO - 'TMOUT': '86400', 15:03:12 INFO - 'USER': 'cltbld', 15:03:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:12 INFO - '_': '/tools/buildbot/bin/python'} 15:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:12 INFO - Running setup.py (path:/tmp/pip-oScpaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:12 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)) 15:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:12 INFO - Running setup.py (path:/tmp/pip-GbVtgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:12 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)) 15:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:12 INFO - Running setup.py (path:/tmp/pip-InU07c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:12 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)) 15:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:12 INFO - Running setup.py (path:/tmp/pip-xT_CkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:12 INFO - Running setup.py (path:/tmp/pip-y2M27Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:12 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)) 15:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:12 INFO - Running setup.py (path:/tmp/pip-xpFNiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:12 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)) 15:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:12 INFO - Running setup.py (path:/tmp/pip-Z0tmen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:13 INFO - Running setup.py (path:/tmp/pip-50Dlpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:13 INFO - Running setup.py (path:/tmp/pip-mgHRAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:13 INFO - Running setup.py (path:/tmp/pip-Trezov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:13 INFO - Running setup.py (path:/tmp/pip-hoxD4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:13 INFO - Running setup.py (path:/tmp/pip-jNMpHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:13 INFO - Running setup.py (path:/tmp/pip-WBI1OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:13 INFO - Running setup.py (path:/tmp/pip-2eU7Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:13 INFO - Running setup.py (path:/tmp/pip-m5XyFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:13 INFO - Running setup.py (path:/tmp/pip-TmcMSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:13 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)) 15:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:13 INFO - Running setup.py (path:/tmp/pip-zGzK1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:13 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)) 15:03:13 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)) 15:03:13 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)) 15:03:13 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)) 15:03:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:15 INFO - Downloading blessings-1.5.1.tar.gz 15:03:15 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 15:03:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:03:15 INFO - Installing collected packages: blessings 15:03:15 INFO - Running setup.py install for blessings 15:03:15 INFO - Successfully installed blessings 15:03:15 INFO - Cleaning up... 15:03:15 INFO - Return code: 0 15:03:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:15 INFO - Reading from file tmpfile_stdout 15:03:15 INFO - Current package versions: 15:03:15 INFO - argparse == 1.2.1 15:03:15 INFO - blessings == 1.5.1 15:03:15 INFO - blobuploader == 1.2.4 15:03:15 INFO - docopt == 0.6.1 15:03:15 INFO - manifestparser == 1.1 15:03:15 INFO - mozInstall == 1.12 15:03:15 INFO - mozcrash == 0.16 15:03:15 INFO - mozdebug == 0.1 15:03:15 INFO - mozdevice == 0.48 15:03:15 INFO - mozfile == 1.2 15:03:15 INFO - mozhttpd == 0.7 15:03:15 INFO - mozinfo == 0.9 15:03:15 INFO - mozleak == 0.1 15:03:15 INFO - mozlog == 3.1 15:03:15 INFO - moznetwork == 0.27 15:03:15 INFO - mozprocess == 0.22 15:03:15 INFO - mozprofile == 0.28 15:03:15 INFO - mozrunner == 6.11 15:03:15 INFO - mozscreenshot == 0.1 15:03:15 INFO - mozsystemmonitor == 0.0 15:03:15 INFO - moztest == 0.7 15:03:15 INFO - mozversion == 1.4 15:03:15 INFO - psutil == 3.1.1 15:03:15 INFO - requests == 1.2.3 15:03:15 INFO - wsgiref == 0.1.2 15:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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/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 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03: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/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 15:03: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/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 15:03:15 INFO - Using env: {'DISPLAY': ':0', 15:03:15 INFO - 'HOME': '/home/cltbld', 15:03:15 INFO - 'LANG': 'en_US.UTF-8', 15:03:15 INFO - 'LANGUAGE': 'en_US:en', 15:03:15 INFO - 'LOGNAME': 'cltbld', 15:03:15 INFO - 'MAIL': '/var/mail/cltbld', 15:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:16 INFO - 'MOZ_NO_REMOTE': '1', 15:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:16 INFO - 'NO_EM_RESTART': '1', 15:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:16 INFO - 'PWD': '/builds/slave/test', 15:03:16 INFO - 'SHELL': '/bin/bash', 15:03:16 INFO - 'SHLVL': '1', 15:03:16 INFO - 'TERM': 'linux', 15:03:16 INFO - 'TMOUT': '86400', 15:03:16 INFO - 'USER': 'cltbld', 15:03:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:16 INFO - '_': '/tools/buildbot/bin/python'} 15:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:03:16 INFO - Cleaning up... 15:03:16 INFO - Return code: 0 15:03:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:16 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 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03:16 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 15:03:16 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 15:03:16 INFO - Using env: {'DISPLAY': ':0', 15:03:16 INFO - 'HOME': '/home/cltbld', 15:03:16 INFO - 'LANG': 'en_US.UTF-8', 15:03:16 INFO - 'LANGUAGE': 'en_US:en', 15:03:16 INFO - 'LOGNAME': 'cltbld', 15:03:16 INFO - 'MAIL': '/var/mail/cltbld', 15:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:16 INFO - 'MOZ_NO_REMOTE': '1', 15:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:16 INFO - 'NO_EM_RESTART': '1', 15:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:16 INFO - 'PWD': '/builds/slave/test', 15:03:16 INFO - 'SHELL': '/bin/bash', 15:03:16 INFO - 'SHLVL': '1', 15:03:16 INFO - 'TERM': 'linux', 15:03:16 INFO - 'TMOUT': '86400', 15:03:16 INFO - 'USER': 'cltbld', 15:03:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:16 INFO - '_': '/tools/buildbot/bin/python'} 15:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:16 INFO - Downloading/unpacking jsonschema 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:03:18 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 15:03:18 INFO - Downloading/unpacking functools32 (from jsonschema) 15:03:18 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 15:03:18 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 15:03:18 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 15:03:18 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 15:03:18 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 15:03:18 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 15:03:18 INFO - Downloading functools32-3.2.3-2.tar.gz 15:03:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:03:18 INFO - warning: no files found matching '*.txt' 15:03:18 INFO - no previously-included directories found matching 'build' 15:03:18 INFO - no previously-included directories found matching 'dist' 15:03:18 INFO - no previously-included directories found matching '.git*' 15:03:18 INFO - Installing collected packages: jsonschema, functools32 15:03:18 INFO - Running setup.py install for functools32 15:03:18 INFO - warning: no files found matching '*.txt' 15:03:18 INFO - no previously-included directories found matching 'build' 15:03:18 INFO - no previously-included directories found matching 'dist' 15:03:18 INFO - no previously-included directories found matching '.git*' 15:03:18 INFO - Successfully installed jsonschema functools32 15:03:18 INFO - Cleaning up... 15:03:18 INFO - Return code: 0 15:03:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f349afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bedd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, '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': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', '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 15:03: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', 'flake8'] in /builds/slave/test/build 15:03: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 flake8 15:03:18 INFO - Using env: {'DISPLAY': ':0', 15:03:18 INFO - 'HOME': '/home/cltbld', 15:03:18 INFO - 'LANG': 'en_US.UTF-8', 15:03:18 INFO - 'LANGUAGE': 'en_US:en', 15:03:18 INFO - 'LOGNAME': 'cltbld', 15:03:18 INFO - 'MAIL': '/var/mail/cltbld', 15:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:18 INFO - 'MOZ_NO_REMOTE': '1', 15:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:18 INFO - 'NO_EM_RESTART': '1', 15:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:18 INFO - 'PWD': '/builds/slave/test', 15:03:18 INFO - 'SHELL': '/bin/bash', 15:03:18 INFO - 'SHLVL': '1', 15:03:18 INFO - 'TERM': 'linux', 15:03:18 INFO - 'TMOUT': '86400', 15:03:18 INFO - 'USER': 'cltbld', 15:03:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:18 INFO - '_': '/tools/buildbot/bin/python'} 15:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:18 INFO - Downloading/unpacking flake8 15:03:18 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 15:03:18 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 15:03:18 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 15:03:18 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 15:03:18 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 15:03:18 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 15:03:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:03:20 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 15:03:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:03:20 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 15:03:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:20 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 15:03:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:03:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:03:21 INFO - no previously-included directories found matching 'docs/_build' 15:03:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:03:21 INFO - Running setup.py install for pep8 15:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:03:21 INFO - no previously-included directories found matching 'docs/_build' 15:03:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:03:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:03:21 INFO - Cleaning up... 15:03:21 INFO - Return code: 0 15:03:21 INFO - Running post-action listener: _resource_record_post_action 15:03:21 INFO - Running post-action listener: _start_resource_monitoring 15:03:21 INFO - Starting resource monitoring. 15:03:21 INFO - ##### 15:03:21 INFO - ##### Running install step. 15:03:21 INFO - ##### 15:03:21 INFO - Running pre-action listener: _resource_record_pre_action 15:03:21 INFO - Running main action method: install 15:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:21 INFO - Reading from file tmpfile_stdout 15:03:21 INFO - Detecting whether we're running mozinstall >=1.0... 15:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:03:21 INFO - Reading from file tmpfile_stdout 15:03:21 INFO - Output received: 15:03:21 INFO - Usage: mozinstall [options] installer 15:03:21 INFO - Options: 15:03:21 INFO - -h, --help show this help message and exit 15:03:21 INFO - -d DEST, --destination=DEST 15:03:21 INFO - Directory to install application into. [default: 15:03:21 INFO - "/builds/slave/test"] 15:03:21 INFO - --app=APP Application being installed. [default: firefox] 15:03:21 INFO - mkdir: /builds/slave/test/build/application 15:03:21 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'] 15:03:21 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 15:03:37 INFO - Reading from file tmpfile_stdout 15:03:37 INFO - Output received: 15:03:37 INFO - /builds/slave/test/build/application/firefox/firefox 15:03:37 INFO - Running post-action listener: _resource_record_post_action 15:03:37 INFO - ##### 15:03:37 INFO - ##### Running run-tests step. 15:03:37 INFO - ##### 15:03:37 INFO - Running pre-action listener: _resource_record_pre_action 15:03:37 INFO - Running main action method: run_tests 15:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:37 INFO - Python 2.7.3 15:03:37 INFO - Return code: 0 15:03:37 INFO - grabbing minidump binary from tooltool 15:03: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')]} 15:03:37 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 0x13513d0>, '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 0x12bced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:37 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 15:03:37 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 15:03:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:37 INFO - Return code: 0 15:03:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:03:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:03:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:03:38 INFO - Return code: 0 15:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:03:38 INFO - Using env: {'DISPLAY': ':0', 15:03:38 INFO - 'HOME': '/home/cltbld', 15:03:38 INFO - 'LANG': 'en_US.UTF-8', 15:03:38 INFO - 'LANGUAGE': 'en_US:en', 15:03:38 INFO - 'LOGNAME': 'cltbld', 15:03:38 INFO - 'MAIL': '/var/mail/cltbld', 15:03:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:38 INFO - 'MOZ_NO_REMOTE': '1', 15:03:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:38 INFO - 'NO_EM_RESTART': '1', 15:03:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:38 INFO - 'PWD': '/builds/slave/test', 15:03:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:38 INFO - 'SHELL': '/bin/bash', 15:03:38 INFO - 'SHLVL': '1', 15:03:38 INFO - 'TERM': 'linux', 15:03:38 INFO - 'TMOUT': '86400', 15:03:38 INFO - 'USER': 'cltbld', 15:03:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993', 15:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:38 INFO - '_': '/tools/buildbot/bin/python'} 15:03:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:03:38 INFO - mozversion application_buildid: 20160119140132 15:03:38 INFO - mozversion application_changeset: 29e2798d08b4fdf50254234dfe6424ca8229b5a0 15:03:38 INFO - mozversion application_display_name: Nightly 15:03:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:38 INFO - mozversion application_name: Firefox 15:03:38 INFO - mozversion application_remotingname: firefox 15:03:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:03:38 INFO - mozversion application_vendor: Mozilla 15:03:38 INFO - mozversion application_version: 46.0a1 15:03:38 INFO - mozversion platform_buildid: 20160119140132 15:03:38 INFO - mozversion platform_changeset: 29e2798d08b4fdf50254234dfe6424ca8229b5a0 15:03:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:03:38 INFO - mozversion platform_version: 46.0a1 15:03:38 INFO - using testdate: 1453244618 15:03:38 INFO - actual date: 1453244618 15:03:38 INFO - starting webserver on 'localhost:49823' 15:03:38 INFO - SUITE-START | Running 3 tests 15:03:38 INFO - TEST-START | dromaeo_css 15:03:38 INFO - operating with platform_type : linux_ 15:03:38 INFO - Initialising browser for dromaeo_css test... 15:03:38 INFO - TEST-INFO | started process 8242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLpq97Z/profile http://localhost:49823/getInfo.html) 15:03:42 INFO - PROCESS | 8242 | -- checkerboarding starts below -- 15:03:42 INFO - PROCESS | 8242 | RENDERTRACE 0.039372 rect red 0 0 1024 768 // viewport 15:03:42 INFO - PROCESS | 8242 | RENDERTRACE 285.531 rect brown 0 0 1024 768 // page 15:03:42 INFO - PROCESS | 8242 | RENDERTRACE 285.564 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 15:03:42 INFO - PROCESS | 8242 | Checkerboarded for 1 frames (299.576 ms), 786432 peak, 13921 severity. 15:03:42 INFO - PROCESS | 8242 | 15:03:42 INFO - PROCESS | 8242 | (process:8323): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:03:43 INFO - PROCESS | 8242 | __metrics Screen width/height:1600/1200 15:03:43 INFO - PROCESS | 8242 | colorDepth:24 15:03:43 INFO - PROCESS | 8242 | Browser inner width/height: 1024/697 15:03:43 INFO - PROCESS | 8242 | __metrics 15:03:43 INFO - PROCESS | 8242 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:03:44 INFO - TEST-INFO | 8242: exit 0 15:03:44 INFO - Browser initialized. 15:03:44 INFO - Running cycle 1/1 for dromaeo_css test... 15:03:44 INFO - TEST-INFO | started process 8372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLpq97Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:45 INFO - PROCESS | 8372 | -- checkerboarding starts below -- 15:03:45 INFO - PROCESS | 8372 | RENDERTRACE 0.053302 rect red 0 0 10 10 // viewport 15:03:45 INFO - PROCESS | 8372 | RENDERTRACE 7.74647 rect red 0 0 10 10 // viewport 15:03:45 INFO - PROCESS | 8372 | RENDERTRACE 30.0027 rect brown 0 0 10 10 // page 15:03:45 INFO - PROCESS | 8372 | RENDERTRACE 30.0322 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 15:03:45 INFO - PROCESS | 8372 | Checkerboarded for 2 frames (33.3983 ms), 100 peak, 774 severity. 15:03:45 INFO - PROCESS | 8372 | 15:03:45 INFO - PROCESS | 8372 | (process:8429): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:03:56 INFO - PROCESS | 8372 | RSS: Main: 150265856 15:03:56 INFO - PROCESS | 8372 | 15:04:45 INFO - PROCESS | 8372 | 1453244685874 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] 15:06:57 INFO - PROCESS | 8372 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49823/tests/dromaeo/cssquery-ext.html) 15:06:58 INFO - PROCESS | 8372 | RSS: Main: 155189248 15:06:58 INFO - PROCESS | 8372 | 15:10:00 INFO - PROCESS | 8372 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-ext.html (next: http://localhost:49823/tests/dromaeo/cssquery-jquery.html) 15:10:01 INFO - PROCESS | 8372 | RSS: Main: 152391680 15:10:01 INFO - PROCESS | 8372 | 15:13:03 INFO - PROCESS | 8372 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49823/tests/dromaeo/cssquery-mootools.html) 15:13:03 INFO - PROCESS | 8372 | RSS: Main: 151552000 15:13:03 INFO - PROCESS | 8372 | 15:16:05 INFO - PROCESS | 8372 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49823/tests/dromaeo/cssquery-prototype.html) 15:16:06 INFO - PROCESS | 8372 | RSS: Main: 150556672 15:16:06 INFO - PROCESS | 8372 | 15:19:08 INFO - PROCESS | 8372 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49823/tests/dromaeo/cssquery-yui.html) 15:19:09 INFO - PROCESS | 8372 | RSS: Main: 151437312 15:19:09 INFO - PROCESS | 8372 | 15:22:11 INFO - PROCESS | 8372 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-yui.html (next: http://localhost:49823/tests/dromaeo/cssquery-dojo.html) 15:22:12 INFO - PROCESS | 8372 | RSS: Main: 154202112 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - PROCESS | 8372 | __start_tp_report 15:22:12 INFO - PROCESS | 8372 | _x_x_mozilla_page_load 15:22:12 INFO - PROCESS | 8372 | _x_x_mozilla_page_load_details 15:22:12 INFO - PROCESS | 8372 | |i|pagename|runs| 15:22:12 INFO - PROCESS | 8372 | |0;dojo.html;2622.370631048548;2624.881880315388;2679.370347968227;2680.4103097318584;2694.77094446972;4412.161689279043;4469.061497085612;4518.909621807562;4529.682922195448;4558.635309175266;4470.530594287602;4519.1413631410005;4554.612857907082;4567.840125595605;4569.611583015448;4201.159768046396;4253.723507971988;4310.439642846425;4311.180875633635;4351.282038463665;4256.148770245948;4259.637930775888;4277.679174061942;4283.785810709468;4290.785460726966;4163.958360416387;4233.301505251629;4236.788160591989;4246;4278.550752171024;4197.370394440828;4254.085371645111;4258.893527661802;4291.806868690916;4292.034292284242;4116.75299482032;4140.130572579732;4148.398482220061;4149.107941792529;4185;4344.174606824725;4395.78021098947;4408.823647054114;4413.889652758675;4415.0066235097165;4901.583365413944;4903.338049363361;4904.278773730786;4925.679830810986;4933.580645645125;4939.925901111486;4950.232713929311;4958.454569997298;4960.2559616057515;4963.826266080706;4344.956550434518;4428.623566996777;4439.445069366329;4529.5243999380245;4611.538846115395;4941.085899108676;4945.406551213805;4973.179425394769;4980.551750342486;5006.724630145377;4736.73947932867;4758.571728544448;4758.762061896891;4779.115863565252;4804.807807687654;4810.8797280068275;4855.36880205571;4888;4891.119598472238;4953.43035550909;4874.707517548958;4893.217085266411;4911.631627627942;4921.924169066006;4956.207006878882;4582.95417045832;4893.124642297246;4893.143699852582;4902.803887844518;4959.355283813081;4097.815598298083;4099.9180016400105;4136.6483848872585;4139.089400331922;4179.164167166578;3554.2180720241504;3602;3626.9637303627155;3636.399994001013;3640.7269454791;4150.149219410074;4213.304804707251;4232.153569286155;4234.428352172479;4245.087306229176;4851.611871050308;4901.950980490221;4904.141775189328;4908.460069392364;4918.11473934688;4147.564505726916;4174.540800511942;4180.770057646859;4187.036981494273;4230.027093768451;4146.66826653867;4342.023044814954;4344;4344.93482597755;4348.847790327323;4567.474740404896;4599.816007359735;4602.838900638529;4622.121796858586;4696.577308042292;4898.289747986593;4899.16714158601;4918.114739346809;4951.034548263054;4992.101421744121;4455.131249406335;4657.371254880683;4689.882752931204;4697.13103075932;4750.049990001944;4692.1084993851055;4719.952800471951;4742.407199100113;4770.236762118045;4830;4796.25658023007;4803.951960480351;4807.4471435785335;4819.445763737215;4859.173940430064;4598.747068911242;4652.860414187579;4654.115718013567;4696.38946936896;4702.741349225826;4692.155412025868;4727.598154156935;4740.691855029412;4745.264484004984;4774.949511107551;4545.886257866844;4567.977160114178;4572.222722137178;4591.127685739699;4602.677812553089;4670.9299360510295;4687.1328804171335;4694.108119457293;4701.7414042228;4743.217369134054;4699.154152252628;4706.835260765857;4732.905341893212;4738.076075165448;4763.452202996561 15:22:12 INFO - PROCESS | 8372 | |1;ext.html;497.25411882176735;517.9507946745059;521.885185259243;523.6334565803938;541.0018515838278;30932;31204.531932021036;31298.374032519336;31438.371232575362;31538.211544711365;35558;35916.281674366495;36130.8193459033;36200.637993620054;36297.45553816695;7600.96199519003;7758.224177582253;7796.571188584626;7797.142314345418;7806.258405451502;7527.698892044339;7671.156172820985;7714.305712485903;7797.727079552217;7836.72571459999;7844.764657060297;7900.723474678359;7917.604119794016;7938.960305198466;7975.760727178165;7848.254415830487;7890.2109789021215;7891.605419729048;7933.286004259644;7937.087234967995;7771.689132434696;7815.6482958267015;7841.882371764428;7902.446828721992;7907.841843163104;33671;33745.15637109067;33816.83091584551;33845.49231761526;33894.81368152103;2819.238805522518;2860.7139286071433;2874.8275103493856;3127.202563346355;3313.370459612666;26855.19434416951;27290.181294561196;27463;27503.31241718953;28115.85942070297;3471.8437670304897;3481.791092534456;3529.1530032791943;3541.4333706606817;3567.23304489536;207620;209081;209460;209848;210491.99999999846;43661.12677746427;44744.77627611841;50306.49693503018;50473.74763126234;50667;45322;45515.08969820585;45660.086798264514;45728.08543829105;45791.54208457939;12212.290279360897;12459.75080498403;12463.5014599415;12473.563425280072;12519.749605007848;9468.19520340765;9582;9585.952070239604;9652.90347096534;9653.276004299705;17167.484975450756;17669.38157164493;17708.29166833338;17753;17792.733109003377;6533.150690410216;6715.966420167868;6831.487638427137;6876.381125698711;6899.344562266577;879.6789171952191;920.1718453392001;1035.5650626736788;1042.3381152967768;1054.267284237463;25151.87424062868;25176.99292028335;25594.74405255961;25894.741052589234;25926.87036564805;960.9039096090474;1032.3238278927315;1082.2694681090234;1092.7759809239087;1097.0729733375285;13190.802137967938;13362.732745345038;13403.597892063253;13546.525871594447;13589.32053397346;249220;251099;251978;253971;256288;43484.56515434805;44089.77955110204;44122.117557648664;44175.558244417785;44251;1120.3222050659397;1233.0885387403653;1236.8515778106505;1238.102375777554;1238.3746208164998;24331.148409805573;24533.87733061395;24766.752332476444;24766.876165619058;24840.503189936462;38429.231415370974;38808.61191388163;38958.220835582564;38993.220135597694;39073.804630976665;229930;234363;234653;235036;235186;27633.585496217976;28072.43855122927;28273.858630706716;28423.715762842934;28430.573541396483;31833;31963.680363196072;32062.03813885587;32685.365731713795;32754.83622581872;29521;29541.85229073841;30278.09165725032;30565.388692225588;30580.694193058676;29158.562621560268;29352.706472935;29695.55456668195;29966.25084372908;30077;30547.847260763552;30786.38427231398;30807.075787726404;30918.845405772827;30924.38151236918;26561.60157597676;27860.860695696392;28459.715402846534;28986.710132898403;29146.27134321659;20889;20896.582068358854;20930.267440639505;21165.788342116382;21216.681749773456 15:22:12 INFO - PROCESS | 8372 | |2;jquery.html;338.44495028153824;338.6410404970733;338.8322780223789;339.97280217582596;341.78296781543713;13869.930650346747;14452.710945781091;14815.851841481583;15061;15551.22243887804;8923.509206993613;9036.412633178856;9239.907600924005;9380.202682771955;9380.671676491324;4308.375285583596;4548.1585906607215;4562.452505699321;4564.612007979309;4569.885752856172;4397.714148580348;4987.725675087869;4990.5508504234795;4995.325631039799;5001.049800537886;3391.796492210463;3560.305740380627;4894.5594896459315;4958.454569997298;4978.352814134158;5057.064443078042;5065.290859279704;5076.416212135615;5079.060373830816;5118.283440318359;4712.717236965759;4914.901701965977;4921.655484116113;4925.187344088221;4928.457869634373;10554.683359499228;10589.682309530726;10740.570377184904;14578.489752858599;16890.324387024506;1695.626962068343;1808.9457316280532;1847.5381154711322;1853.184598776534;1923.7691477022706;8238.299744521662;8388.832223355499;8516.82966340676;8540.658373665046;8563;1581.1935912684614;1593.346727841591;1595.2582049347109;1595.4894433781194;1637.050510703801;47068.52931470676;47106.99999999966;48812.51187488115;48812.75593622045;48946;9031.864522032174;9207.125323094295;9384.483853388128;9452.385594936308;9505.42967421957;11936.985356244817;11977.401129943468;11990.760184796256;11996.700082498008;12009.63971080869;6764.222114456802;6907.274736152732;6942.895856562156;6959.617221052789;6973.19808222061;6538.738450462023;6620.933790662128;6629.701663425158;6677.198736151693;6708.893032649558;3914.5889681583026;3927;4007.0984028593334;4019.7588144711412;4070.2266569351727;1610.2029495399852;1672.74908763684;1677.6309211973346;1685.9831401686072;1690.0620155813397;344.36980326003356;346.69664043961535;348.6496071448229;353.57747491747114;834.837206744679;8663.133686631287;9106.225970792557;9135.725928222164;9157.31320150978;9165.083491650781;378.34357389928454;378.7822002348661;383.8944290320184;392.3526181799996;405.2968100345897;5107.897842043212;5109.795608175631;5115.437301896788;5186.40356359016;5201.141811601044;432532;434517;436043;455903;463244;37814;38327.80836095801;55289.44710552843;60205.79588408207;60895.69552152211;415.9168166366739;422.4107370218528;423.41145807327837;423.6610711430843;425.62119713455047;8660.263877570476;8791.296696264411;8813.074627164311;8841.204291613785;8851.911480885366;25941.35146621274;26098.60852087182;26451.60322595124;26491.337716557242;26521.469570608093;36891.262174755815;38580.421293680054;38699.41950870796;38708;40255.59744402636;5870.913880932041;5933.347331793413;6126.356732543019;6167.814965551041;6190.7523699051535;5317.1226747586215;8904.332175087024;9294.349395542247;9343.909586018395;9491.288153388385;7757.612119394121;8158.510489370657;8335.249827515552;8443.113473085483;9137.314701397288;8739.956300218459;8912.688055918012;8961.507117108622;9260.30547708938;9383.202427793714;8653.437526560754;8838.558072096497;9210.217131543894;9219.216366608645;9298.674546390845;6530.216374035146;6679.666016699049;6685.097511836035;6717.630530320879;6928.965355173192;7658.319588144105;8670.609822557873;8776.824463510822;8788.604512797066;8959.148880856568 15:22:12 INFO - PROCESS | 8372 | |3;mootools.html;1315.4409376015192;1327.8845769553577;1398.888088952884;1619.9028058316494;1655.2634077835369;5963.493103086243;6066.454019138277;6590.8681826363445;6750.5949643021395;6751.021101940222;6404.807855764335;6520.152380190569;6601.669916504167;6611.471082313404;6617.569857959242;2008.4376374615058;2037.7147199392023;2041.6937459381063;2043.5095577061472;2048.764392094906;1993.5215548268384;2022.29219773079;2023.4030960866505;2025.250657256817;2029.147757941668;1994.1923520973955;1995.072291384506;2002.029015927274;2015.0529251251962;2021.0198053943825;1997.0414201183514;2002.1290738528787;2019.404275738646;2019.899005049749;2021.4339984804205;1956.6086782643386;1957.4029920874127;2030.46192758919;2035.3893831850385;2040.3674860793053;6834.794956151323;6842.726290948356;6870.45036397087;6874.450043996469;6895.689693963784;3855.903602409934;3983;3985.681145508381;3989.2420440116284;3993.2412841560013;2605.8566778827158;2638.340414896276;2666.9466610667873;2672.291842661696;2673.986630066857;813.6989313953875;815.8980127484065;830.219593582037;832.6253186066294;839.102160688064;9010.504422256774;9075;9086.545672716404;9104.044075372056;9138.497382643953;3538.327717733622;3563.964360356415;3585.94621080684;3596.7841929484316;3617.04148400674;7777.416693747991;7788.493747906368;7789.065312162576;7791.571463569559;7807.6486558105025;4002.479677641946;4007.719459637797;4012.8394864205106;4021.1756589899;4032.4152997815154;3096.690330966885;3166.1293144385477;3512.6838584527513;3655.1958569114754;3669.688076513526;3203.5354873543206;3207.2623296641905;3213.4055199788113;3217.7264932480534;3247.7239434647845;1030.3611760708409;1034.927555071153;1040.0639424517994;1045.132539991805;1053.889341619119;1130.773845230957;1138.1179585821055;1139.8632164140356;1165.155262434728;1165.5221359242669;6092.817215483543;6110.083487476825;6127.325994140641;6139.6009259398;6139.907901381483;994.6916455898695;1002.9554016524513;1008.3042700536606;1014.4319181258519;1019.7807471393537;5015.22264049073;5117.232415137759;5132.589392848563;5144.639875208774;5158.432572417031;7947;8000.959995199987;8105.8378832424205;8130.512169269863;8254.42219044661;7893.447458677838;7957.840843183104;8022.839543209103;8038.155993620586;8047.678092876336;6196.783112591038;6196.938030619726;6223.502119830403;6272.3100458949475;6303.495720342362;5958.612690175125;6145.047517634774;6171.9074213887725;6178.382161783786;6188.969055154876;7144.535605185646;7231.63841807897;7278.818029549304;7281.963590182015;7356.337929586149;7319.268073192851;7427.071616047994;7448.590327531821;7491.625418729151;7562.697492100255;5363.651362661414;5550.944490555043;5995.910061348996;6076.270847498328;6085.148079268817;6118.847028824137;6216.191895053614;6254.655993920378;6267.62394256346;6278.591891527036;5797.449242321973;5841.18223448709;5842.678652674143;5953.166556681981;5973;5680.6591604503865;5900.734466949083;5948.196993405835;5956.791512297049;5974.522038236843;5715.51418129447;5776.7111644418455;5805.506531944832;6057.363976782374;6066.605670631395;5455.045367060828;5468.644538105011;5494.972525137348;5496.780128794803;5497.642653227527;5369.677819330853;5393.352797664148;5397.271368365377;5419.078756611464;5422.186671999231 15:22:12 INFO - PROCESS | 8372 | |4;prototype.html;290.82405144887343;292.5100456734969;296.3302935366072;299.4056797257445;302.02897683946117;5365.758540865666;5433.7283135843245;5487.451254874511;5510.035743744844;5562.3881373048935;5361.839144825662;5418.160185171295;5480.04099282625;5487.890242195163;5576.358718747345;4287.828486860538;4290.892727681818;4297.183535128315;4298.935515967263;4299.075698724773;4291.35629655551;4294.420253265816;4296.763677997709;4302.053548219403;4311.439512863323;4050.6354428101463;4190.811413486385;4252.978735106336;4271.67962402821;4281.079567892903;4177.143685544456;4177.227212965611;4181.665466762652;4184.497860256758;4191.685623578229;3611.1152767571853;3613.1509095362567;3615.7649752765988;3616;3630.9273814523826;5241.947580524184;5333.626646134772;5337;5343.465653434664;5353.866153346158;4662.9067418651775;4664.207084795559;4676.859694209179;4697.906041879178;4707.270373092176;5910.172575839386;5930.347661757203;5943;5945;5952.58331916766;3744.0826997385543;3783.1677031053123;3803.581606023335;3813.2945405099867;3818.1218319786603;6171.105189747506;6274.466670333027;6274.843128921768;6275.121482992385;6307.24313082433;4096.426500289962;4104.958950410517;4110.321796903478;4111.424400583921;4115.32097203958;4139.172165566899;4163.208990291835;4165.625093741578;4167.91664166715;4171.290880550314;4848.442429120626;4857.368542089576;4862.440819305754;4864.075825593126;4876;5698.287714035746;5924.318703349084;5927.051671732502;5932.614380065282;5935.703214839327;1400.0199860097973;1412.159764939859;1420.2472689474596;1424.950126745559;1444.8627380398846;932.7994481186441;943.5518128888723;948.6158105967095;949.710338346797;951.9143277105094;5160.380754309507;5162.483751624883;5163.173892177234;5167.0957582422925;5171.5862730981435;6112.388761123852;6150.6320066774615;6155.784547540815;6164.506839452833;6178.783742568989;5149.098907691139;5149.176131818891;5150.227465880148;5158.613104017214;5162.586993040548;3231.337575796956;3274.410606090879;3323.4682450807754;3336.649651786576;3341.047801376596;5888.941110588925;5892.469677729025;5895.764169433261;5896.941030589639;5907.261592300963;6179.412955769195;6406.949776071612;6428.453581445536;6435.710393032325;6448.967755161194;5866.413358664099;5869.647821130746;5875.089361149029;5878.353381128072;5886.058230683156;6132.846678833065;6208.782692605737;6213.96893015532;6222;6224.657643829451;5942.762289508371;5975.43233392827;6095.725692343944;6095.908561371672;6107.144999700135;5868.2077919480325;5873.676947767743;5883.470487656132;5884.352721200579;5887.882242355215;4042.797860106924;4061.2080644274083;4074.022234663719;4077.7145599807727;4085.693572981979;6077.544184186116;6246.562740608114;6247.187865577446;6261.092141639346;6263.655498947602;5972.193753843176;5984.700764961647;5988.431099045583;6001.159837622824;6009.519238461;5972.462478376967;5976.133460648269;6000.759969601167;6062.696865156813;6086.02623580225;5510.972445137749;5818.272715910512;5819.621724587888;5830.096335067901;5856.180134781219;5983.670898100646;5984.640921544721;6008.699565021644;6011.0382338825575;6016.338202797601;5843.357230704704;5859.765609375577;5866.911996319973;5878.823635290948;5879.882402351844 15:22:12 INFO - PROCESS | 8372 | |5;yui.html;645.1194120026163;649.0361812708128;734.4344854462064;743.6207534157578;764.9694012239511;10803.83794243086;10807.729806754834;11102.222844400885;11112.333260004405;11135.220534562564;10339.689809305733;10346.172306215503;10392.48037598119;10401.271910966216;10411.687649370511;728.7667946257213;740.2819265312638;741.0958630470817;744.2483092077014;745.6495447139836;731.2906480713726;734.0274136768803;737.2664199121881;742.4283301857566;743.8289193485501;768.8808234723626;769.8922150898878;770.3182683325241;770.3336613829025;772.4708574626371;753;757.8029712274794;759.4342215049768;762.0246085011195;767.4129291092319;568.3691102875805;570.2045646323397;570.8201916396322;571.0349509329262;573.3120255693185;10642.308249963806;10662.200334974908;10832.295900766503;10840.783184336347;10856.674299771019;11486.483108260149;11687.123465740104;11720.531178752839;11936.641900742905;12337.07471939599;9488.905110948872;9571.37786043912;9641.035896410373;9673.129418352311;9680.90319096807;3275.8034517928763;3326.085326535198;3335.0495108893847;3345.1637090727318;3441.0365097772665;35769.64230357715;35974.28051438983;36028.459573106426;36082.63917360819;36102.097447563756;8944.239739622075;9205.677801276923;9309.767255818524;9380.577873995686;9526.809463810685;15696.921515392578;15733.292001859943;15839.02012248469;15898.284577194054;16002.279897404645;6328.272248691367;6449.097126402214;6490.383413575702;6566.212054553484;6566.343365663491;3611.1513794258326;3617.963820361763;3627.303740688089;3648.3797754381817;3659.304732100892;2614.058938782037;2637.6966648835246;2650.0062476571284;2657.2028391482477;2665.5202063628344;436.8776742512102;438.29872204473224;442.33207856137466;446.41519609311905;448.1619371774802;444.5798720209436;456.9809325204812;502.46989426155756;517.5445607865055;537.5860587347798;7033.964830175919;7124.928750712426;7285.7814265572115;7502.812429689301;7906.893034975108;399.8460592671784;444.50437761895256;484;497.4701942431299;515.6957395136812;3349.882754103595;3438.6045604755273;3443.6728510791436;3449.9443798729744;3476.0440878758545;46816.76591617088;47480.762596186796;47648.76175619169;47675;47683;41635.37546936798;41725.79137104356;41976.58023419788;42106.57893421088;42783;37172;38360.616393836266;38537.80731096327;39023.60976390257;39201.41197882034;6754.3921047106;6860.451163906776;6916.585004899722;6960.4779641526075;7059.682314295972;27391.45217095687;27418.17745467639;27982.58026129569;28111.71888281091;28174.85912570424;34538.309233815686;37862.62137378591;38146.809265953496;38355.42466863055;38357.424638631004;8455;8476.957615211884;8525.10486398944;8546.871796923175;8596.871046934426;9553.904460955302;9667.226621870093;9833.213342932691;9853.113219810251;10113.089821916063;9104.317176211678;9186.724398268063;9368.67209647659;9389.953050234704;9694.709158725249;9158.908410915805;9221.538923053955;9277.396969196981;9314.673986410444;9581.904180958101;9616.182624476998;9705.078017588317;9727.270454715783;9799.314048016571;9801.215902727621;7880.84238315219;7890.842183156419;7909.644066017158;7916.643751031333;8502.277306428776;7999.400044996532;8203.753887383149;8373;8446.408751387344;8563.100874408097 15:22:12 INFO - PROCESS | 8372 | __end_tp_report 15:22:12 INFO - PROCESS | 8372 | __start_cc_report 15:22:12 INFO - PROCESS | 8372 | _x_x_mozilla_cycle_collect,328 15:22:12 INFO - PROCESS | 8372 | __end_cc_report 15:22:12 INFO - PROCESS | 8372 | __startTimestamp1453245732048__endTimestamp 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - PROCESS | 8372 | ------- Summary: start ------- 15:22:12 INFO - PROCESS | 8372 | Number of tests: 6 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - PROCESS | 8372 | [#0] dojo.html Cycles:165 Average:4500.40 Median:4599.82 stddev:455.04 (9.9%) stddev-sans-first:431.93 15:22:12 INFO - PROCESS | 8372 | Values: 2622.4 2624.9 2679.4 2680.4 2694.8 4412.2 4469.1 4518.9 4529.7 4558.6 4470.5 4519.1 4554.6 4567.8 4569.6 4201.2 4253.7 4310.4 4311.2 4351.3 4256.1 4259.6 4277.7 4283.8 4290.8 4164.0 4233.3 4236.8 4246.0 4278.6 4197.4 4254.1 4258.9 4291.8 4292.0 4116.8 4140.1 4148.4 4149.1 4185.0 4344.2 4395.8 4408.8 4413.9 4415.0 4901.6 4903.3 4904.3 4925.7 4933.6 4939.9 4950.2 4958.5 4960.3 4963.8 4345.0 4428.6 4439.4 4529.5 4611.5 4941.1 4945.4 4973.2 4980.6 5006.7 4736.7 4758.6 4758.8 4779.1 4804.8 4810.9 4855.4 4888.0 4891.1 4953.4 4874.7 4893.2 4911.6 4921.9 4956.2 4583.0 4893.1 4893.1 4902.8 4959.4 4097.8 4099.9 4136.6 4139.1 4179.2 3554.2 3602.0 3627.0 3636.4 3640.7 4150.1 4213.3 4232.2 4234.4 4245.1 4851.6 4902.0 4904.1 4908.5 4918.1 4147.6 4174.5 4180.8 4187.0 4230.0 4146.7 4342.0 4344.0 4344.9 4348.8 4567.5 4599.8 4602.8 4622.1 4696.6 4898.3 4899.2 4918.1 4951.0 4992.1 4455.1 4657.4 4689.9 4697.1 4750.0 4692.1 4720.0 4742.4 4770.2 4830.0 4796.3 4804.0 4807.4 4819.4 4859.2 4598.7 4652.9 4654.1 4696.4 4702.7 4692.2 4727.6 4740.7 4745.3 4774.9 4545.9 4568.0 4572.2 4591.1 4602.7 4670.9 4687.1 4694.1 4701.7 4743.2 4699.2 4706.8 4732.9 4738.1 4763.5 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - PROCESS | 8372 | [#1] ext.html Cycles:180 Average:37785.21 Median:31068.27 stddev:60503.06 (194.7%) stddev-sans-first:60608.00 15:22:12 INFO - PROCESS | 8372 | Values: 497.3 518.0 521.9 523.6 541.0 30932.0 31204.5 31298.4 31438.4 31538.2 35558.0 35916.3 36130.8 36200.6 36297.5 7601.0 7758.2 7796.6 7797.1 7806.3 7527.7 7671.2 7714.3 7797.7 7836.7 7844.8 7900.7 7917.6 7939.0 7975.8 7848.3 7890.2 7891.6 7933.3 7937.1 7771.7 7815.6 7841.9 7902.4 7907.8 33671.0 33745.2 33816.8 33845.5 33894.8 2819.2 2860.7 2874.8 3127.2 3313.4 26855.2 27290.2 27463.0 27503.3 28115.9 3471.8 3481.8 3529.2 3541.4 3567.2 207620.0 209081.0 209460.0 209848.0 210492.0 43661.1 44744.8 50306.5 50473.7 50667.0 45322.0 45515.1 45660.1 45728.1 45791.5 12212.3 12459.8 12463.5 12473.6 12519.7 9468.2 9582.0 9586.0 9652.9 9653.3 17167.5 17669.4 17708.3 17753.0 17792.7 6533.2 6716.0 6831.5 6876.4 6899.3 879.7 920.2 1035.6 1042.3 1054.3 25151.9 25177.0 25594.7 25894.7 25926.9 960.9 1032.3 1082.3 1092.8 1097.1 13190.8 13362.7 13403.6 13546.5 13589.3 249220.0 251099.0 251978.0 253971.0 256288.0 43484.6 44089.8 44122.1 44175.6 44251.0 1120.3 1233.1 1236.9 1238.1 1238.4 24331.1 24533.9 24766.8 24766.9 24840.5 38429.2 38808.6 38958.2 38993.2 39073.8 229930.0 234363.0 234653.0 235036.0 235186.0 27633.6 28072.4 28273.9 28423.7 28430.6 31833.0 31963.7 32062.0 32685.4 32754.8 29521.0 29541.9 30278.1 30565.4 30580.7 29158.6 29352.7 29695.6 29966.3 30077.0 30547.8 30786.4 30807.1 30918.8 30924.4 26561.6 27860.9 28459.7 28986.7 29146.3 20889.0 20896.6 20930.3 21165.8 21216.7 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - PROCESS | 8372 | [#2] jquery.html Cycles:180 Average:22265.71 Median:4968.40 stddev:72593.36 (1461.1%) stddev-sans-first:72778.33 15:22:12 INFO - PROCESS | 8372 | Values: 338.4 338.6 338.8 340.0 341.8 13869.9 14452.7 14815.9 15061.0 15551.2 8923.5 9036.4 9239.9 9380.2 9380.7 4308.4 4548.2 4562.5 4564.6 4569.9 4397.7 4987.7 4990.6 4995.3 5001.0 3391.8 3560.3 4894.6 4958.5 4978.4 5057.1 5065.3 5076.4 5079.1 5118.3 4712.7 4914.9 4921.7 4925.2 4928.5 10554.7 10589.7 10740.6 14578.5 16890.3 1695.6 1808.9 1847.5 1853.2 1923.8 8238.3 8388.8 8516.8 8540.7 8563.0 1581.2 1593.3 1595.3 1595.5 1637.1 47068.5 47107.0 48812.5 48812.8 48946.0 9031.9 9207.1 9384.5 9452.4 9505.4 11937.0 11977.4 11990.8 11996.7 12009.6 6764.2 6907.3 6942.9 6959.6 6973.2 6538.7 6620.9 6629.7 6677.2 6708.9 3914.6 3927.0 4007.1 4019.8 4070.2 1610.2 1672.7 1677.6 1686.0 1690.1 344.4 346.7 348.6 353.6 834.8 8663.1 9106.2 9135.7 9157.3 9165.1 378.3 378.8 383.9 392.4 405.3 5107.9 5109.8 5115.4 5186.4 5201.1 432532.0 434517.0 436043.0 455903.0 463244.0 37814.0 38327.8 55289.4 60205.8 60895.7 415.9 422.4 423.4 423.7 425.6 8660.3 8791.3 8813.1 8841.2 8851.9 25941.4 26098.6 26451.6 26491.3 26521.5 36891.3 38580.4 38699.4 38708.0 40255.6 5870.9 5933.3 6126.4 6167.8 6190.8 5317.1 8904.3 9294.3 9343.9 9491.3 7757.6 8158.5 8335.2 8443.1 9137.3 8740.0 8912.7 8961.5 9260.3 9383.2 8653.4 8838.6 9210.2 9219.2 9298.7 6530.2 6679.7 6685.1 6717.6 6929.0 7658.3 8670.6 8776.8 8788.6 8959.1 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - PROCESS | 8372 | [#3] mootools.html Cycles:180 Average:4669.33 Median:5615.80 stddev:2384.61 (42.5%) stddev-sans-first:2377.97 15:22:12 INFO - PROCESS | 8372 | Values: 1315.4 1327.9 1398.9 1619.9 1655.3 5963.5 6066.5 6590.9 6750.6 6751.0 6404.8 6520.2 6601.7 6611.5 6617.6 2008.4 2037.7 2041.7 2043.5 2048.8 1993.5 2022.3 2023.4 2025.3 2029.1 1994.2 1995.1 2002.0 2015.1 2021.0 1997.0 2002.1 2019.4 2019.9 2021.4 1956.6 1957.4 2030.5 2035.4 2040.4 6834.8 6842.7 6870.5 6874.5 6895.7 3855.9 3983.0 3985.7 3989.2 3993.2 2605.9 2638.3 2666.9 2672.3 2674.0 813.7 815.9 830.2 832.6 839.1 9010.5 9075.0 9086.5 9104.0 9138.5 3538.3 3564.0 3585.9 3596.8 3617.0 7777.4 7788.5 7789.1 7791.6 7807.6 4002.5 4007.7 4012.8 4021.2 4032.4 3096.7 3166.1 3512.7 3655.2 3669.7 3203.5 3207.3 3213.4 3217.7 3247.7 1030.4 1034.9 1040.1 1045.1 1053.9 1130.8 1138.1 1139.9 1165.2 1165.5 6092.8 6110.1 6127.3 6139.6 6139.9 994.7 1003.0 1008.3 1014.4 1019.8 5015.2 5117.2 5132.6 5144.6 5158.4 7947.0 8001.0 8105.8 8130.5 8254.4 7893.4 7957.8 8022.8 8038.2 8047.7 6196.8 6196.9 6223.5 6272.3 6303.5 5958.6 6145.0 6171.9 6178.4 6189.0 7144.5 7231.6 7278.8 7282.0 7356.3 7319.3 7427.1 7448.6 7491.6 7562.7 5363.7 5550.9 5995.9 6076.3 6085.1 6118.8 6216.2 6254.7 6267.6 6278.6 5797.4 5841.2 5842.7 5953.2 5973.0 5680.7 5900.7 5948.2 5956.8 5974.5 5715.5 5776.7 5805.5 6057.4 6066.6 5455.0 5468.6 5495.0 5496.8 5497.6 5369.7 5393.4 5397.3 5419.1 5422.2 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - PROCESS | 8372 | [#4] prototype.html Cycles:180 Average:4866.35 Median:5487.67 stddev:1491.39 (27.2%) stddev-sans-first:1455.50 15:22:12 INFO - PROCESS | 8372 | Values: 290.8 292.5 296.3 299.4 302.0 5365.8 5433.7 5487.5 5510.0 5562.4 5361.8 5418.2 5480.0 5487.9 5576.4 4287.8 4290.9 4297.2 4298.9 4299.1 4291.4 4294.4 4296.8 4302.1 4311.4 4050.6 4190.8 4253.0 4271.7 4281.1 4177.1 4177.2 4181.7 4184.5 4191.7 3611.1 3613.2 3615.8 3616.0 3630.9 5241.9 5333.6 5337.0 5343.5 5353.9 4662.9 4664.2 4676.9 4697.9 4707.3 5910.2 5930.3 5943.0 5945.0 5952.6 3744.1 3783.2 3803.6 3813.3 3818.1 6171.1 6274.5 6274.8 6275.1 6307.2 4096.4 4105.0 4110.3 4111.4 4115.3 4139.2 4163.2 4165.6 4167.9 4171.3 4848.4 4857.4 4862.4 4864.1 4876.0 5698.3 5924.3 5927.1 5932.6 5935.7 1400.0 1412.2 1420.2 1425.0 1444.9 932.8 943.6 948.6 949.7 951.9 5160.4 5162.5 5163.2 5167.1 5171.6 6112.4 6150.6 6155.8 6164.5 6178.8 5149.1 5149.2 5150.2 5158.6 5162.6 3231.3 3274.4 3323.5 3336.6 3341.0 5888.9 5892.5 5895.8 5896.9 5907.3 6179.4 6406.9 6428.5 6435.7 6449.0 5866.4 5869.6 5875.1 5878.4 5886.1 6132.8 6208.8 6214.0 6222.0 6224.7 5942.8 5975.4 6095.7 6095.9 6107.1 5868.2 5873.7 5883.5 5884.4 5887.9 4042.8 4061.2 4074.0 4077.7 4085.7 6077.5 6246.6 6247.2 6261.1 6263.7 5972.2 5984.7 5988.4 6001.2 6009.5 5972.5 5976.1 6000.8 6062.7 6086.0 5511.0 5818.3 5819.6 5830.1 5856.2 5983.7 5984.6 6008.7 6011.0 6016.3 5843.4 5859.8 5866.9 5878.8 5879.9 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - PROCESS | 8372 | [#5] yui.html Cycles:180 Average:11401.92 Median:552.98 stddev:12913.74 (2335.3%) stddev-sans-first:12924.70 15:22:12 INFO - PROCESS | 8372 | Values: 645.1 649.0 734.4 743.6 765.0 10803.8 10807.7 11102.2 11112.3 11135.2 10339.7 10346.2 10392.5 10401.3 10411.7 728.8 740.3 741.1 744.2 745.6 731.3 734.0 737.3 742.4 743.8 768.9 769.9 770.3 770.3 772.5 753.0 757.8 759.4 762.0 767.4 568.4 570.2 570.8 571.0 573.3 10642.3 10662.2 10832.3 10840.8 10856.7 11486.5 11687.1 11720.5 11936.6 12337.1 9488.9 9571.4 9641.0 9673.1 9680.9 3275.8 3326.1 3335.0 3345.2 3441.0 35769.6 35974.3 36028.5 36082.6 36102.1 8944.2 9205.7 9309.8 9380.6 9526.8 15696.9 15733.3 15839.0 15898.3 16002.3 6328.3 6449.1 6490.4 6566.2 6566.3 3611.2 3618.0 3627.3 3648.4 3659.3 2614.1 2637.7 2650.0 2657.2 2665.5 436.9 438.3 442.3 446.4 448.2 444.6 457.0 502.5 517.5 537.6 7034.0 7124.9 7285.8 7502.8 7906.9 399.8 444.5 484.0 497.5 515.7 3349.9 3438.6 3443.7 3449.9 3476.0 46816.8 47480.8 47648.8 47675.0 47683.0 41635.4 41725.8 41976.6 42106.6 42783.0 37172.0 38360.6 38537.8 39023.6 39201.4 6754.4 6860.5 6916.6 6960.5 7059.7 27391.5 27418.2 27982.6 28111.7 28174.9 34538.3 37862.6 38146.8 38355.4 38357.4 8455.0 8477.0 8525.1 8546.9 8596.9 9553.9 9667.2 9833.2 9853.1 10113.1 9104.3 9186.7 9368.7 9390.0 9694.7 9158.9 9221.5 9277.4 9314.7 9581.9 9616.2 9705.1 9727.3 9799.3 9801.2 7880.8 7890.8 7909.6 7916.6 8502.3 7999.4 8203.8 8373.0 8446.4 8563.1 15:22:12 INFO - PROCESS | 8372 | -------- Summary: end -------- 15:22:12 INFO - PROCESS | 8372 | 15:22:12 INFO - TEST-INFO | 8372: exit 0 15:22:12 INFO - TEST-OK | dromaeo_css | took 1114071ms 15:22:12 INFO - TEST-START | kraken 15:22:12 INFO - operating with platform_type : linux_ 15:22:12 INFO - Initialising browser for kraken test... 15:22:12 INFO - TEST-INFO | started process 8614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WEkUN/profile http://localhost:49823/getInfo.html) 15:22:16 INFO - PROCESS | 8614 | 15:22:16 INFO - PROCESS | 8614 | (process:8683): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:22:17 INFO - PROCESS | 8614 | __metrics Screen width/height:1600/1200 15:22:17 INFO - PROCESS | 8614 | colorDepth:24 15:22:17 INFO - PROCESS | 8614 | Browser inner width/height: 1024/697 15:22:17 INFO - PROCESS | 8614 | __metrics 15:22:17 INFO - PROCESS | 8614 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:22:18 INFO - TEST-INFO | 8614: exit 0 15:22:18 INFO - Browser initialized. 15:22:18 INFO - Running cycle 1/1 for kraken test... 15:22:18 INFO - TEST-INFO | started process 8732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WEkUN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:19 INFO - PROCESS | 8732 | -- checkerboarding starts below -- 15:22:19 INFO - PROCESS | 8732 | RENDERTRACE 0.067557 rect red 0 0 10 10 // viewport 15:22:19 INFO - PROCESS | 8732 | RENDERTRACE 35.3545 rect brown 0 0 10 10 // page 15:22:19 INFO - PROCESS | 8732 | RENDERTRACE 35.3783 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 15:22:19 INFO - PROCESS | 8732 | Checkerboarded for 1 frames (36.9065 ms), 100 peak, 3 severity. 15:22:19 INFO - PROCESS | 8732 | 15:22:19 INFO - PROCESS | 8732 | (process:8789): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:22:30 INFO - PROCESS | 8732 | RSS: Main: 150282240 15:22:30 INFO - PROCESS | 8732 | 15:22:32 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49823/tests/kraken/driver.html?testName=audio-beat-detection) 15:22:33 INFO - PROCESS | 8732 | RSS: Main: 150732800 15:22:33 INFO - PROCESS | 8732 | 15:22:36 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49823/tests/kraken/driver.html?testName=audio-dft) 15:22:36 INFO - PROCESS | 8732 | RSS: Main: 153939968 15:22:36 INFO - PROCESS | 8732 | 15:22:39 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49823/tests/kraken/driver.html?testName=audio-fft) 15:22:40 INFO - PROCESS | 8732 | RSS: Main: 149057536 15:22:40 INFO - PROCESS | 8732 | 15:22:42 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49823/tests/kraken/driver.html?testName=audio-oscillator) 15:22:43 INFO - PROCESS | 8732 | RSS: Main: 148942848 15:22:43 INFO - PROCESS | 8732 | 15:22:45 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:22:45 INFO - PROCESS | 8732 | RSS: Main: 149536768 15:22:45 INFO - PROCESS | 8732 | 15:22:48 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49823/tests/kraken/driver.html?testName=imaging-darkroom) 15:22:49 INFO - PROCESS | 8732 | RSS: Main: 148094976 15:22:49 INFO - PROCESS | 8732 | 15:22:53 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49823/tests/kraken/driver.html?testName=imaging-desaturate) 15:22:53 INFO - PROCESS | 8732 | RSS: Main: 146800640 15:22:53 INFO - PROCESS | 8732 | 15:22:56 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49823/tests/kraken/driver.html?testName=json-parse-financial) 15:22:57 INFO - PROCESS | 8732 | RSS: Main: 146464768 15:22:57 INFO - PROCESS | 8732 | 15:22:59 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:22:59 INFO - PROCESS | 8732 | RSS: Main: 147685376 15:22:59 INFO - PROCESS | 8732 | 15:23:01 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:23:02 INFO - PROCESS | 8732 | RSS: Main: 148795392 15:23:02 INFO - PROCESS | 8732 | 15:23:04 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:23:04 INFO - PROCESS | 8732 | RSS: Main: 148836352 15:23:04 INFO - PROCESS | 8732 | 15:23:07 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:23:08 INFO - PROCESS | 8732 | RSS: Main: 149139456 15:23:08 INFO - PROCESS | 8732 | 15:23:10 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:23:11 INFO - PROCESS | 8732 | RSS: Main: 148545536 15:23:11 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49823/tests/kraken/driver.html?testName=ai-astar) 15:23:13 INFO - PROCESS | 8732 | RSS: Main: 149778432 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | __start_tp_report 15:23:13 INFO - PROCESS | 8732 | _x_x_mozilla_page_load 15:23:13 INFO - PROCESS | 8732 | _x_x_mozilla_page_load_details 15:23:13 INFO - PROCESS | 8732 | |i|pagename|runs| 15:23:13 INFO - PROCESS | 8732 | |0;ai-astar;116;111;120;120;115;128;114;116;117;114 15:23:13 INFO - PROCESS | 8732 | |1;audio-beat-detection;154;135;156;165;135;156;162;142;168;134 15:23:13 INFO - PROCESS | 8732 | |2;audio-dft;164;164;164;166;163;167;174;165;163;162 15:23:13 INFO - PROCESS | 8732 | |3;audio-fft;75;76;74;153;74;74;74;74;160;78 15:23:13 INFO - PROCESS | 8732 | |4;audio-oscillator;98;99;135;97;98;105;132;98;98;131 15:23:13 INFO - PROCESS | 8732 | |5;imaging-gaussian-blur;110;110;110;110;110;111;110;109;109;110 15:23:13 INFO - PROCESS | 8732 | |6;imaging-darkroom;148;148;147;148;148;146;148;149;152;147 15:23:13 INFO - PROCESS | 8732 | |7;imaging-desaturate;96;97;97;97;96;96;96;100;96;96 15:23:13 INFO - PROCESS | 8732 | |8;json-parse-financial;74;72;71;72;73;74;72;73;71;69 15:23:13 INFO - PROCESS | 8732 | |9;json-stringify-tinderbox;68;69;68;68;69;68;69;72;68;69 15:23:13 INFO - PROCESS | 8732 | |10;stanford-crypto-aes;84;81;85;93;83;85;84;85;85;94 15:23:13 INFO - PROCESS | 8732 | |11;stanford-crypto-ccm;128;124;124;122;127;123;120;124;126;120 15:23:13 INFO - PROCESS | 8732 | |12;stanford-crypto-pbkdf2;141;143;155;169;139;141;151;150;153;152 15:23:13 INFO - PROCESS | 8732 | |13;stanford-crypto-sha256-iterative;72;71;72;71;73;71;72;72;71;71 15:23:13 INFO - PROCESS | 8732 | __end_tp_report 15:23:13 INFO - PROCESS | 8732 | __start_cc_report 15:23:13 INFO - PROCESS | 8732 | _x_x_mozilla_cycle_collect,792 15:23:13 INFO - PROCESS | 8732 | __end_cc_report 15:23:13 INFO - PROCESS | 8732 | __startTimestamp1453245793328__endTimestamp 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | ------- Summary: start ------- 15:23:13 INFO - PROCESS | 8732 | Number of tests: 14 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#0] ai-astar Cycles:10 Average:117.10 Median:116.50 stddev:4.70 (4.0%) stddev-sans-first:4.97 15:23:13 INFO - PROCESS | 8732 | Values: 116.0 111.0 120.0 120.0 115.0 128.0 114.0 116.0 117.0 114.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:156.00 stddev:13.11 (8.4%) stddev-sans-first:13.85 15:23:13 INFO - PROCESS | 8732 | Values: 154.0 135.0 156.0 165.0 135.0 156.0 162.0 142.0 168.0 134.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:3.43 (2.1%) stddev-sans-first:3.61 15:23:13 INFO - PROCESS | 8732 | Values: 164.0 164.0 164.0 166.0 163.0 167.0 174.0 165.0 163.0 162.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.00 stddev:34.48 (46.6%) stddev-sans-first:36.07 15:23:13 INFO - PROCESS | 8732 | Values: 75.0 76.0 74.0 153.0 74.0 74.0 74.0 74.0 160.0 78.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:98.00 stddev:16.44 (16.8%) stddev-sans-first:16.94 15:23:13 INFO - PROCESS | 8732 | Values: 98.0 99.0 135.0 97.0 98.0 105.0 132.0 98.0 98.0 131.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:23:13 INFO - PROCESS | 8732 | Values: 110.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 109.0 110.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.60 (1.1%) stddev-sans-first:1.69 15:23:13 INFO - PROCESS | 8732 | Values: 148.0 148.0 147.0 148.0 148.0 146.0 148.0 149.0 152.0 147.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.30 15:23:13 INFO - PROCESS | 8732 | Values: 96.0 97.0 97.0 97.0 96.0 96.0 96.0 100.0 96.0 96.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.50 stddev:1.52 (2.1%) stddev-sans-first:1.45 15:23:13 INFO - PROCESS | 8732 | Values: 74.0 72.0 71.0 72.0 73.0 74.0 72.0 73.0 71.0 69.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 15:23:13 INFO - PROCESS | 8732 | Values: 68.0 69.0 68.0 68.0 69.0 68.0 69.0 72.0 68.0 69.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:4.20 (4.9%) stddev-sans-first:4.40 15:23:13 INFO - PROCESS | 8732 | Values: 84.0 81.0 85.0 93.0 83.0 85.0 84.0 85.0 85.0 94.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.00 stddev:2.70 (2.2%) stddev-sans-first:2.40 15:23:13 INFO - PROCESS | 8732 | Values: 128.0 124.0 124.0 122.0 127.0 123.0 120.0 124.0 126.0 120.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:151.50 stddev:9.00 (5.9%) stddev-sans-first:9.01 15:23:13 INFO - PROCESS | 8732 | Values: 141.0 143.0 155.0 169.0 139.0 141.0 151.0 150.0 153.0 152.0 15:23:13 INFO - PROCESS | 8732 | 15:23:13 INFO - PROCESS | 8732 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 15:23:13 INFO - PROCESS | 8732 | Values: 72.0 71.0 72.0 71.0 73.0 71.0 72.0 72.0 71.0 71.0 15:23:13 INFO - PROCESS | 8732 | -------- Summary: end -------- 15:23:13 INFO - PROCESS | 8732 | 15:23:14 INFO - TEST-INFO | 8732: exit 0 15:23:14 INFO - TEST-OK | kraken | took 61606ms 15:23:14 INFO - TEST-START | v8_7 15:23:14 INFO - operating with platform_type : linux_ 15:23:14 INFO - Initialising browser for v8_7 test... 15:23:14 INFO - TEST-INFO | started process 9017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX16aJV/profile http://localhost:49823/getInfo.html) 15:23:18 INFO - PROCESS | 9017 | 15:23:18 INFO - PROCESS | 9017 | (process:9087): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:23:18 INFO - PROCESS | 9017 | __metrics Screen width/height:1600/1200 15:23:18 INFO - PROCESS | 9017 | colorDepth:24 15:23:18 INFO - PROCESS | 9017 | Browser inner width/height: 1024/697 15:23:18 INFO - PROCESS | 9017 | __metrics 15:23:18 INFO - PROCESS | 9017 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:23:19 INFO - TEST-INFO | 9017: exit 0 15:23:19 INFO - Browser initialized. 15:23:19 INFO - Running cycle 1/1 for v8_7 test... 15:23:19 INFO - TEST-INFO | started process 9136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX16aJV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:20 INFO - PROCESS | 9136 | -- checkerboarding starts below -- 15:23:20 INFO - PROCESS | 9136 | RENDERTRACE 0.037926 rect red 0 0 10 10 // viewport 15:23:20 INFO - PROCESS | 9136 | RENDERTRACE 59.1818 rect brown 0 0 10 10 // page 15:23:20 INFO - PROCESS | 9136 | RENDERTRACE 59.2182 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 15:23:20 INFO - PROCESS | 9136 | Checkerboarded for 1 frames (67.3798 ms), 100 peak, 1 severity. 15:23:21 INFO - PROCESS | 9136 | 15:23:21 INFO - PROCESS | 9136 | (process:9191): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:23:31 INFO - PROCESS | 9136 | RSS: Main: 149639168 15:23:31 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | Cycle 1(1): loaded http://localhost:49823/tests/v8_7/run.html (next: http://localhost:49823/tests/v8_7/run.html) 15:23:54 INFO - PROCESS | 9136 | RSS: Main: 145592320 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | __start_tp_report 15:23:54 INFO - PROCESS | 9136 | _x_x_mozilla_page_load 15:23:54 INFO - PROCESS | 9136 | _x_x_mozilla_page_load_details 15:23:54 INFO - PROCESS | 9136 | |i|pagename|runs| 15:23:54 INFO - PROCESS | 9136 | |0;Richards;167.8697330871244 15:23:54 INFO - PROCESS | 9136 | |1;DeltaBlue;185.8390633711206 15:23:54 INFO - PROCESS | 9136 | |2;Encrypt;279.4857462269424 15:23:54 INFO - PROCESS | 9136 | |3;Decrypt;5213.541666666667 15:23:54 INFO - PROCESS | 9136 | |4;RayTrace;1064.9627263045793 15:23:54 INFO - PROCESS | 9136 | |5;Earley;767.4597083653108 15:23:54 INFO - PROCESS | 9136 | |6;Boyer;12500 15:23:54 INFO - PROCESS | 9136 | |7;RegExp;43565.217391304344 15:23:54 INFO - PROCESS | 9136 | |8;Splay;600.6006006006006 15:23:54 INFO - PROCESS | 9136 | |9;NavierStokes;4822.115384615385 15:23:54 INFO - PROCESS | 9136 | __end_tp_report 15:23:54 INFO - PROCESS | 9136 | __startTimestamp1453245834563__endTimestamp 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | ------- Summary: start ------- 15:23:54 INFO - PROCESS | 9136 | Number of tests: 10 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 167.9 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#1] DeltaBlue Cycles:1 Average:185.84 Median:185.84 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 185.8 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 279.5 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 5213.5 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#4] RayTrace Cycles:1 Average:1064.96 Median:1064.96 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 1065.0 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#5] Earley Cycles:1 Average:767.46 Median:767.46 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 767.5 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 12500.0 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#7] RegExp Cycles:1 Average:43565.22 Median:43565.22 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 43565.2 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#8] Splay Cycles:1 Average:600.60 Median:600.60 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 600.6 15:23:54 INFO - PROCESS | 9136 | 15:23:54 INFO - PROCESS | 9136 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 15:23:54 INFO - PROCESS | 9136 | Values: 4822.1 15:23:54 INFO - PROCESS | 9136 | -------- Summary: end -------- 15:23:54 INFO - PROCESS | 9136 | 15:23:55 INFO - TEST-INFO | 9136: exit 0 15:23:55 INFO - TEST-OK | v8_7 | took 41170ms 15:23:55 INFO - SUITE-END | took 1216s 15:23:55 INFO - Completed test suite (00:20:16) 15:23:55 INFO - Working with test: dromaeo_css 15:23:55 INFO - Generating results file: dromaeo_css 15:23:55 INFO - Working with test: kraken 15:23:55 INFO - Generating results file: kraken 15:23:55 INFO - javascript benchmark 15:23:55 INFO - Working with test: v8_7 15:23:55 INFO - Generating results file: v8_7 15:23:55 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:23:55 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 15:23:55 INFO - process_Request line: dromaeo_css 5864.42 graph.html#tests=[[72,132,43]] 15:23:55 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:23:55 INFO - process_Request line: kraken 1559.60 graph.html#tests=[[232,132,43]] 15:23:55 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:23:55 INFO - process_Request line: v8_7 20110.07 graph.html#tests=[[230,132,43]] 15:23:55 INFO - RETURN: dromaeo_css: 5864.42 15:23:55 INFO - RETURN: kraken: 1559.60 15:23:55 INFO - RETURN: v8_7: 20110.07 15:23:55 INFO - javascript benchmark 15:23:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.370631048548, 2624.881880315388, 2679.370347968227, 2680.4103097318584, 2694.77094446972, 4412.161689279043, 4469.061497085612, 4518.909621807562, 4529.682922195448, 4558.635309175266, 4470.530594287602, 4519.1413631410005, 4554.612857907082, 4567.840125595605, 4569.611583015448, 4201.159768046396, 4253.723507971988, 4310.439642846425, 4311.180875633635, 4351.282038463665, 4256.148770245948, 4259.637930775888, 4277.679174061942, 4283.785810709468, 4290.785460726966, 4163.958360416387, 4233.301505251629, 4236.788160591989, 4246.0, 4278.550752171024, 4197.370394440828, 4254.085371645111, 4258.893527661802, 4291.806868690916, 4292.034292284242, 4116.75299482032, 4140.130572579732, 4148.398482220061, 4149.107941792529, 4185.0, 4344.174606824725, 4395.78021098947, 4408.823647054114, 4413.889652758675, 4415.0066235097165, 4901.583365413944, 4903.338049363361, 4904.278773730786, 4925.679830810986, 4933.580645645125, 4939.925901111486, 4950.232713929311, 4958.454569997298, 4960.2559616057515, 4963.826266080706, 4344.956550434518, 4428.623566996777, 4439.445069366329, 4529.5243999380245, 4611.538846115395, 4941.085899108676, 4945.406551213805, 4973.179425394769, 4980.551750342486, 5006.724630145377, 4736.73947932867, 4758.571728544448, 4758.762061896891, 4779.115863565252, 4804.807807687654, 4810.8797280068275, 4855.36880205571, 4888.0, 4891.119598472238, 4953.43035550909, 4874.707517548958, 4893.217085266411, 4911.631627627942, 4921.924169066006, 4956.207006878882, 4582.95417045832, 4893.124642297246, 4893.143699852582, 4902.803887844518, 4959.355283813081, 4097.815598298083, 4099.9180016400105, 4136.6483848872585, 4139.089400331922, 4179.164167166578, 3554.2180720241504, 3602.0, 3626.9637303627155, 3636.399994001013, 3640.7269454791, 4150.149219410074, 4213.304804707251, 4232.153569286155, 4234.428352172479, 4245.087306229176, 4851.611871050308, 4901.950980490221, 4904.141775189328, 4908.460069392364, 4918.11473934688, 4147.564505726916, 4174.540800511942, 4180.770057646859, 4187.036981494273, 4230.027093768451, 4146.66826653867, 4342.023044814954, 4344.0, 4344.93482597755, 4348.847790327323, 4567.474740404896, 4599.816007359735, 4602.838900638529, 4622.121796858586, 4696.577308042292, 4898.289747986593, 4899.16714158601, 4918.114739346809, 4951.034548263054, 4992.101421744121, 4455.131249406335, 4657.371254880683, 4689.882752931204, 4697.13103075932, 4750.049990001944, 4692.1084993851055, 4719.952800471951, 4742.407199100113, 4770.236762118045, 4830.0, 4796.25658023007, 4803.951960480351, 4807.4471435785335, 4819.445763737215, 4859.173940430064, 4598.747068911242, 4652.860414187579, 4654.115718013567, 4696.38946936896, 4702.741349225826, 4692.155412025868, 4727.598154156935, 4740.691855029412, 4745.264484004984, 4774.949511107551, 4545.886257866844, 4567.977160114178, 4572.222722137178, 4591.127685739699, 4602.677812553089, 4670.9299360510295, 4687.1328804171335, 4694.108119457293, 4701.7414042228, 4743.217369134054, 4699.154152252628, 4706.835260765857, 4732.905341893212, 4738.076075165448, 4763.452202996561], "unit": "score", "name": "dojo.html", "value": 4473.128464294647}, {"lowerIsBetter": false, "replicates": [497.25411882176735, 517.9507946745059, 521.885185259243, 523.6334565803938, 541.0018515838278, 30932.0, 31204.531932021036, 31298.374032519336, 31438.371232575362, 31538.211544711365, 35558.0, 35916.281674366495, 36130.8193459033, 36200.637993620054, 36297.45553816695, 7600.96199519003, 7758.224177582253, 7796.571188584626, 7797.142314345418, 7806.258405451502, 7527.698892044339, 7671.156172820985, 7714.305712485903, 7797.727079552217, 7836.72571459999, 7844.764657060297, 7900.723474678359, 7917.604119794016, 7938.960305198466, 7975.760727178165, 7848.254415830487, 7890.2109789021215, 7891.605419729048, 7933.286004259644, 7937.087234967995, 7771.689132434696, 7815.6482958267015, 7841.882371764428, 7902.446828721992, 7907.841843163104, 33671.0, 33745.15637109067, 33816.83091584551, 33845.49231761526, 33894.81368152103, 2819.238805522518, 2860.7139286071433, 2874.8275103493856, 3127.202563346355, 3313.370459612666, 26855.19434416951, 27290.181294561196, 27463.0, 27503.31241718953, 28115.85942070297, 3471.8437670304897, 3481.791092534456, 3529.1530032791943, 3541.4333706606817, 3567.23304489536, 207620.0, 209081.0, 209460.0, 209848.0, 210491.99999999846, 43661.12677746427, 44744.77627611841, 50306.49693503018, 50473.74763126234, 50667.0, 45322.0, 45515.08969820585, 45660.086798264514, 45728.08543829105, 45791.54208457939, 12212.290279360897, 12459.75080498403, 12463.5014599415, 12473.563425280072, 12519.749605007848, 9468.19520340765, 9582.0, 9585.952070239604, 9652.90347096534, 9653.276004299705, 17167.484975450756, 17669.38157164493, 17708.29166833338, 17753.0, 17792.733109003377, 6533.150690410216, 6715.966420167868, 6831.487638427137, 6876.381125698711, 6899.344562266577, 879.6789171952191, 920.1718453392001, 1035.5650626736788, 1042.3381152967768, 1054.267284237463, 25151.87424062868, 25176.99292028335, 25594.74405255961, 25894.741052589234, 25926.87036564805, 960.9039096090474, 1032.3238278927315, 1082.2694681090234, 1092.7759809239087, 1097.0729733375285, 13190.802137967938, 13362.732745345038, 13403.597892063253, 13546.525871594447, 13589.32053397346, 249220.0, 251099.0, 251978.0, 253971.0, 256288.0, 43484.56515434805, 44089.77955110204, 44122.117557648664, 44175.558244417785, 44251.0, 1120.3222050659397, 1233.0885387403653, 1236.8515778106505, 1238.102375777554, 1238.3746208164998, 24331.148409805573, 24533.87733061395, 24766.752332476444, 24766.876165619058, 24840.503189936462, 38429.231415370974, 38808.61191388163, 38958.220835582564, 38993.220135597694, 39073.804630976665, 229930.0, 234363.0, 234653.0, 235036.0, 235186.0, 27633.585496217976, 28072.43855122927, 28273.858630706716, 28423.715762842934, 28430.573541396483, 31833.0, 31963.680363196072, 32062.03813885587, 32685.365731713795, 32754.83622581872, 29521.0, 29541.85229073841, 30278.09165725032, 30565.388692225588, 30580.694193058676, 29158.562621560268, 29352.706472935, 29695.55456668195, 29966.25084372908, 30077.0, 30547.847260763552, 30786.38427231398, 30807.075787726404, 30918.845405772827, 30924.38151236918, 26561.60157597676, 27860.860695696392, 28459.715402846534, 28986.710132898403, 29146.27134321659, 20889.0, 20896.582068358854, 20930.267440639505, 21165.788342116382, 21216.681749773456], "unit": "score", "name": "ext.html", "value": 15893.208275687199}, {"lowerIsBetter": false, "replicates": [338.44495028153824, 338.6410404970733, 338.8322780223789, 339.97280217582596, 341.78296781543713, 13869.930650346747, 14452.710945781091, 14815.851841481583, 15061.0, 15551.22243887804, 8923.509206993613, 9036.412633178856, 9239.907600924005, 9380.202682771955, 9380.671676491324, 4308.375285583596, 4548.1585906607215, 4562.452505699321, 4564.612007979309, 4569.885752856172, 4397.714148580348, 4987.725675087869, 4990.5508504234795, 4995.325631039799, 5001.049800537886, 3391.796492210463, 3560.305740380627, 4894.5594896459315, 4958.454569997298, 4978.352814134158, 5057.064443078042, 5065.290859279704, 5076.416212135615, 5079.060373830816, 5118.283440318359, 4712.717236965759, 4914.901701965977, 4921.655484116113, 4925.187344088221, 4928.457869634373, 10554.683359499228, 10589.682309530726, 10740.570377184904, 14578.489752858599, 16890.324387024506, 1695.626962068343, 1808.9457316280532, 1847.5381154711322, 1853.184598776534, 1923.7691477022706, 8238.299744521662, 8388.832223355499, 8516.82966340676, 8540.658373665046, 8563.0, 1581.1935912684614, 1593.346727841591, 1595.2582049347109, 1595.4894433781194, 1637.050510703801, 47068.52931470676, 47106.99999999966, 48812.51187488115, 48812.75593622045, 48946.0, 9031.864522032174, 9207.125323094295, 9384.483853388128, 9452.385594936308, 9505.42967421957, 11936.985356244817, 11977.401129943468, 11990.760184796256, 11996.700082498008, 12009.63971080869, 6764.222114456802, 6907.274736152732, 6942.895856562156, 6959.617221052789, 6973.19808222061, 6538.738450462023, 6620.933790662128, 6629.701663425158, 6677.198736151693, 6708.893032649558, 3914.5889681583026, 3927.0, 4007.0984028593334, 4019.7588144711412, 4070.2266569351727, 1610.2029495399852, 1672.74908763684, 1677.6309211973346, 1685.9831401686072, 1690.0620155813397, 344.36980326003356, 346.69664043961535, 348.6496071448229, 353.57747491747114, 834.837206744679, 8663.133686631287, 9106.225970792557, 9135.725928222164, 9157.31320150978, 9165.083491650781, 378.34357389928454, 378.7822002348661, 383.8944290320184, 392.3526181799996, 405.2968100345897, 5107.897842043212, 5109.795608175631, 5115.437301896788, 5186.40356359016, 5201.141811601044, 432532.0, 434517.0, 436043.0, 455903.0, 463244.0, 37814.0, 38327.80836095801, 55289.44710552843, 60205.79588408207, 60895.69552152211, 415.9168166366739, 422.4107370218528, 423.41145807327837, 423.6610711430843, 425.62119713455047, 8660.263877570476, 8791.296696264411, 8813.074627164311, 8841.204291613785, 8851.911480885366, 25941.35146621274, 26098.60852087182, 26451.60322595124, 26491.337716557242, 26521.469570608093, 36891.262174755815, 38580.421293680054, 38699.41950870796, 38708.0, 40255.59744402636, 5870.913880932041, 5933.347331793413, 6126.356732543019, 6167.814965551041, 6190.7523699051535, 5317.1226747586215, 8904.332175087024, 9294.349395542247, 9343.909586018395, 9491.288153388385, 7757.612119394121, 8158.510489370657, 8335.249827515552, 8443.113473085483, 9137.314701397288, 8739.956300218459, 8912.688055918012, 8961.507117108622, 9260.30547708938, 9383.202427793714, 8653.437526560754, 8838.558072096497, 9210.217131543894, 9219.216366608645, 9298.674546390845, 6530.216374035146, 6679.666016699049, 6685.097511836035, 6717.630530320879, 6928.965355173192, 7658.319588144105, 8670.609822557873, 8776.824463510822, 8788.604512797066, 8959.148880856568], "unit": "score", "name": "jquery.html", "value": 6346.4162464896535}, {"lowerIsBetter": false, "replicates": [1315.4409376015192, 1327.8845769553577, 1398.888088952884, 1619.9028058316494, 1655.2634077835369, 5963.493103086243, 6066.454019138277, 6590.8681826363445, 6750.5949643021395, 6751.021101940222, 6404.807855764335, 6520.152380190569, 6601.669916504167, 6611.471082313404, 6617.569857959242, 2008.4376374615058, 2037.7147199392023, 2041.6937459381063, 2043.5095577061472, 2048.764392094906, 1993.5215548268384, 2022.29219773079, 2023.4030960866505, 2025.250657256817, 2029.147757941668, 1994.1923520973955, 1995.072291384506, 2002.029015927274, 2015.0529251251962, 2021.0198053943825, 1997.0414201183514, 2002.1290738528787, 2019.404275738646, 2019.899005049749, 2021.4339984804205, 1956.6086782643386, 1957.4029920874127, 2030.46192758919, 2035.3893831850385, 2040.3674860793053, 6834.794956151323, 6842.726290948356, 6870.45036397087, 6874.450043996469, 6895.689693963784, 3855.903602409934, 3983.0, 3985.681145508381, 3989.2420440116284, 3993.2412841560013, 2605.8566778827158, 2638.340414896276, 2666.9466610667873, 2672.291842661696, 2673.986630066857, 813.6989313953875, 815.8980127484065, 830.219593582037, 832.6253186066294, 839.102160688064, 9010.504422256774, 9075.0, 9086.545672716404, 9104.044075372056, 9138.497382643953, 3538.327717733622, 3563.964360356415, 3585.94621080684, 3596.7841929484316, 3617.04148400674, 7777.416693747991, 7788.493747906368, 7789.065312162576, 7791.571463569559, 7807.6486558105025, 4002.479677641946, 4007.719459637797, 4012.8394864205106, 4021.1756589899, 4032.4152997815154, 3096.690330966885, 3166.1293144385477, 3512.6838584527513, 3655.1958569114754, 3669.688076513526, 3203.5354873543206, 3207.2623296641905, 3213.4055199788113, 3217.7264932480534, 3247.7239434647845, 1030.3611760708409, 1034.927555071153, 1040.0639424517994, 1045.132539991805, 1053.889341619119, 1130.773845230957, 1138.1179585821055, 1139.8632164140356, 1165.155262434728, 1165.5221359242669, 6092.817215483543, 6110.083487476825, 6127.325994140641, 6139.6009259398, 6139.907901381483, 994.6916455898695, 1002.9554016524513, 1008.3042700536606, 1014.4319181258519, 1019.7807471393537, 5015.22264049073, 5117.232415137759, 5132.589392848563, 5144.639875208774, 5158.432572417031, 7947.0, 8000.959995199987, 8105.8378832424205, 8130.512169269863, 8254.42219044661, 7893.447458677838, 7957.840843183104, 8022.839543209103, 8038.155993620586, 8047.678092876336, 6196.783112591038, 6196.938030619726, 6223.502119830403, 6272.3100458949475, 6303.495720342362, 5958.612690175125, 6145.047517634774, 6171.9074213887725, 6178.382161783786, 6188.969055154876, 7144.535605185646, 7231.63841807897, 7278.818029549304, 7281.963590182015, 7356.337929586149, 7319.268073192851, 7427.071616047994, 7448.590327531821, 7491.625418729151, 7562.697492100255, 5363.651362661414, 5550.944490555043, 5995.910061348996, 6076.270847498328, 6085.148079268817, 6118.847028824137, 6216.191895053614, 6254.655993920378, 6267.62394256346, 6278.591891527036, 5797.449242321973, 5841.18223448709, 5842.678652674143, 5953.166556681981, 5973.0, 5680.6591604503865, 5900.734466949083, 5948.196993405835, 5956.791512297049, 5974.522038236843, 5715.51418129447, 5776.7111644418455, 5805.506531944832, 6057.363976782374, 6066.605670631395, 5455.045367060828, 5468.644538105011, 5494.972525137348, 5496.780128794803, 5497.642653227527, 5369.677819330853, 5393.352797664148, 5397.271368365377, 5419.078756611464, 5422.186671999231], "unit": "score", "name": "mootools.html", "value": 3875.1663721063296}, {"lowerIsBetter": false, "replicates": [290.82405144887343, 292.5100456734969, 296.3302935366072, 299.4056797257445, 302.02897683946117, 5365.758540865666, 5433.7283135843245, 5487.451254874511, 5510.035743744844, 5562.3881373048935, 5361.839144825662, 5418.160185171295, 5480.04099282625, 5487.890242195163, 5576.358718747345, 4287.828486860538, 4290.892727681818, 4297.183535128315, 4298.935515967263, 4299.075698724773, 4291.35629655551, 4294.420253265816, 4296.763677997709, 4302.053548219403, 4311.439512863323, 4050.6354428101463, 4190.811413486385, 4252.978735106336, 4271.67962402821, 4281.079567892903, 4177.143685544456, 4177.227212965611, 4181.665466762652, 4184.497860256758, 4191.685623578229, 3611.1152767571853, 3613.1509095362567, 3615.7649752765988, 3616.0, 3630.9273814523826, 5241.947580524184, 5333.626646134772, 5337.0, 5343.465653434664, 5353.866153346158, 4662.9067418651775, 4664.207084795559, 4676.859694209179, 4697.906041879178, 4707.270373092176, 5910.172575839386, 5930.347661757203, 5943.0, 5945.0, 5952.58331916766, 3744.0826997385543, 3783.1677031053123, 3803.581606023335, 3813.2945405099867, 3818.1218319786603, 6171.105189747506, 6274.466670333027, 6274.843128921768, 6275.121482992385, 6307.24313082433, 4096.426500289962, 4104.958950410517, 4110.321796903478, 4111.424400583921, 4115.32097203958, 4139.172165566899, 4163.208990291835, 4165.625093741578, 4167.91664166715, 4171.290880550314, 4848.442429120626, 4857.368542089576, 4862.440819305754, 4864.075825593126, 4876.0, 5698.287714035746, 5924.318703349084, 5927.051671732502, 5932.614380065282, 5935.703214839327, 1400.0199860097973, 1412.159764939859, 1420.2472689474596, 1424.950126745559, 1444.8627380398846, 932.7994481186441, 943.5518128888723, 948.6158105967095, 949.710338346797, 951.9143277105094, 5160.380754309507, 5162.483751624883, 5163.173892177234, 5167.0957582422925, 5171.5862730981435, 6112.388761123852, 6150.6320066774615, 6155.784547540815, 6164.506839452833, 6178.783742568989, 5149.098907691139, 5149.176131818891, 5150.227465880148, 5158.613104017214, 5162.586993040548, 3231.337575796956, 3274.410606090879, 3323.4682450807754, 3336.649651786576, 3341.047801376596, 5888.941110588925, 5892.469677729025, 5895.764169433261, 5896.941030589639, 5907.261592300963, 6179.412955769195, 6406.949776071612, 6428.453581445536, 6435.710393032325, 6448.967755161194, 5866.413358664099, 5869.647821130746, 5875.089361149029, 5878.353381128072, 5886.058230683156, 6132.846678833065, 6208.782692605737, 6213.96893015532, 6222.0, 6224.657643829451, 5942.762289508371, 5975.43233392827, 6095.725692343944, 6095.908561371672, 6107.144999700135, 5868.2077919480325, 5873.676947767743, 5883.470487656132, 5884.352721200579, 5887.882242355215, 4042.797860106924, 4061.2080644274083, 4074.022234663719, 4077.7145599807727, 4085.693572981979, 6077.544184186116, 6246.562740608114, 6247.187865577446, 6261.092141639346, 6263.655498947602, 5972.193753843176, 5984.700764961647, 5988.431099045583, 6001.159837622824, 6009.519238461, 5972.462478376967, 5976.133460648269, 6000.759969601167, 6062.696865156813, 6086.02623580225, 5510.972445137749, 5818.272715910512, 5819.621724587888, 5830.096335067901, 5856.180134781219, 5983.670898100646, 5984.640921544721, 6008.699565021644, 6011.0382338825575, 6016.338202797601, 5843.357230704704, 5859.765609375577, 5866.911996319973, 5878.823635290948, 5879.882402351844], "unit": "score", "name": "prototype.html", "value": 4373.577118177354}, {"lowerIsBetter": false, "replicates": [645.1194120026163, 649.0361812708128, 734.4344854462064, 743.6207534157578, 764.9694012239511, 10803.83794243086, 10807.729806754834, 11102.222844400885, 11112.333260004405, 11135.220534562564, 10339.689809305733, 10346.172306215503, 10392.48037598119, 10401.271910966216, 10411.687649370511, 728.7667946257213, 740.2819265312638, 741.0958630470817, 744.2483092077014, 745.6495447139836, 731.2906480713726, 734.0274136768803, 737.2664199121881, 742.4283301857566, 743.8289193485501, 768.8808234723626, 769.8922150898878, 770.3182683325241, 770.3336613829025, 772.4708574626371, 753.0, 757.8029712274794, 759.4342215049768, 762.0246085011195, 767.4129291092319, 568.3691102875805, 570.2045646323397, 570.8201916396322, 571.0349509329262, 573.3120255693185, 10642.308249963806, 10662.200334974908, 10832.295900766503, 10840.783184336347, 10856.674299771019, 11486.483108260149, 11687.123465740104, 11720.531178752839, 11936.641900742905, 12337.07471939599, 9488.905110948872, 9571.37786043912, 9641.035896410373, 9673.129418352311, 9680.90319096807, 3275.8034517928763, 3326.085326535198, 3335.0495108893847, 3345.1637090727318, 3441.0365097772665, 35769.64230357715, 35974.28051438983, 36028.459573106426, 36082.63917360819, 36102.097447563756, 8944.239739622075, 9205.677801276923, 9309.767255818524, 9380.577873995686, 9526.809463810685, 15696.921515392578, 15733.292001859943, 15839.02012248469, 15898.284577194054, 16002.279897404645, 6328.272248691367, 6449.097126402214, 6490.383413575702, 6566.212054553484, 6566.343365663491, 3611.1513794258326, 3617.963820361763, 3627.303740688089, 3648.3797754381817, 3659.304732100892, 2614.058938782037, 2637.6966648835246, 2650.0062476571284, 2657.2028391482477, 2665.5202063628344, 436.8776742512102, 438.29872204473224, 442.33207856137466, 446.41519609311905, 448.1619371774802, 444.5798720209436, 456.9809325204812, 502.46989426155756, 517.5445607865055, 537.5860587347798, 7033.964830175919, 7124.928750712426, 7285.7814265572115, 7502.812429689301, 7906.893034975108, 399.8460592671784, 444.50437761895256, 484.0, 497.4701942431299, 515.6957395136812, 3349.882754103595, 3438.6045604755273, 3443.6728510791436, 3449.9443798729744, 3476.0440878758545, 46816.76591617088, 47480.762596186796, 47648.76175619169, 47675.0, 47683.0, 41635.37546936798, 41725.79137104356, 41976.58023419788, 42106.57893421088, 42783.0, 37172.0, 38360.616393836266, 38537.80731096327, 39023.60976390257, 39201.41197882034, 6754.3921047106, 6860.451163906776, 6916.585004899722, 6960.4779641526075, 7059.682314295972, 27391.45217095687, 27418.17745467639, 27982.58026129569, 28111.71888281091, 28174.85912570424, 34538.309233815686, 37862.62137378591, 38146.809265953496, 38355.42466863055, 38357.424638631004, 8455.0, 8476.957615211884, 8525.10486398944, 8546.871796923175, 8596.871046934426, 9553.904460955302, 9667.226621870093, 9833.213342932691, 9853.113219810251, 10113.089821916063, 9104.317176211678, 9186.724398268063, 9368.67209647659, 9389.953050234704, 9694.709158725249, 9158.908410915805, 9221.538923053955, 9277.396969196981, 9314.673986410444, 9581.904180958101, 9616.182624476998, 9705.078017588317, 9727.270454715783, 9799.314048016571, 9801.215902727621, 7880.84238315219, 7890.842183156419, 7909.644066017158, 7916.643751031333, 8502.277306428776, 7999.400044996532, 8203.753887383149, 8373.0, 8446.408751387344, 8563.100874408097], "unit": "score", "name": "yui.html", "value": 5319.003707949939}], "name": "dromaeo_css", "value": 5864.420125335105}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 111.0, 120.0, 120.0, 115.0, 128.0, 114.0, 116.0, 117.0, 114.0], "unit": "score", "name": "ai-astar", "value": 117.1}, {"lowerIsBetter": true, "replicates": [154.0, 135.0, 156.0, 165.0, 135.0, 156.0, 162.0, 142.0, 168.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 166.0, 163.0, 167.0, 174.0, 165.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 165.2}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 74.0, 153.0, 74.0, 74.0, 74.0, 74.0, 160.0, 78.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 135.0, 97.0, 98.0, 105.0, 132.0, 98.0, 98.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 146.0, 148.0, 149.0, 152.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 100.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 71.0, 72.0, 73.0, 74.0, 72.0, 73.0, 71.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 72.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 85.0, 93.0, 83.0, 85.0, 84.0, 85.0, 85.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [128.0, 124.0, 124.0, 122.0, 127.0, 123.0, 120.0, 124.0, 126.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [141.0, 143.0, 155.0, 169.0, 139.0, 141.0, 151.0, 150.0, 153.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 71.0, 73.0, 71.0, 72.0, 72.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1559.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.8697330871244], "unit": "score", "name": "Richards", "value": 210.29401399999998}, {"lowerIsBetter": false, "replicates": [185.8390633711206], "unit": "score", "name": "DeltaBlue", "value": 355.78095800000017}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1064.9627263045793], "unit": "score", "name": "RayTrace", "value": 694.8496709999997}, {"lowerIsBetter": false, "replicates": [767.4597083653108], "unit": "score", "name": "Earley", "value": 868.401289}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [43565.217391304344], "unit": "score", "name": "RegExp", "value": 20.91083333333335}, {"lowerIsBetter": false, "replicates": [600.6006006006006], "unit": "score", "name": "Splay", "value": 135.68251500000005}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20110.07449514559}]} 15:23:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20110.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1559.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5864.42"}}} 15:23:55 INFO - Return code: 0 15:23:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:23:55 INFO - # TBPL SUCCESS # 15:23:55 INFO - Running post-action listener: _resource_record_post_action 15:23:55 INFO - Running post-run listener: _resource_record_post_run 15:23:56 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 539701248; Read time: 0; Write time: 456712 15:23:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 230334464; Read time: 0; Write time: 270700 15:23:56 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 309366784; Read time: 0; Write time: 186012 15:23:56 INFO - Running post-run listener: _upload_blobber_files 15:23:56 INFO - Blob upload gear active. 15:23:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:23:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:23:57 INFO - (blobuploader) - INFO - Open directory for files ... 15:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:23:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:58 INFO - (blobuploader) - INFO - Done attempting. 15:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:59 INFO - (blobuploader) - INFO - Done attempting. 15:23:59 INFO - (blobuploader) - INFO - Iteration through files over. 15:23:59 INFO - Return code: 0 15:23:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:23:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:23:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d900879fdabbec39e26e17ff604f6bd56ceac5d81b02dd7a366cbb6e5fc0ed47f7bb7fd7c7e1bb72a2379c992ec09c019fc3ff71d219162e1e6bc6b9e9324b90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0272b9f07c14a0f546b49a98b19927e69f3f92275feb795f50952f50a4587e41e2b8e5a898d6091008297bcce2f9f32105c3f742d8d36260b2ecbcf244d952ed"} 15:23:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:23:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:23:59 INFO - Contents: 15:23:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d900879fdabbec39e26e17ff604f6bd56ceac5d81b02dd7a366cbb6e5fc0ed47f7bb7fd7c7e1bb72a2379c992ec09c019fc3ff71d219162e1e6bc6b9e9324b90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0272b9f07c14a0f546b49a98b19927e69f3f92275feb795f50952f50a4587e41e2b8e5a898d6091008297bcce2f9f32105c3f742d8d36260b2ecbcf244d952ed"} 15:23:59 INFO - Running post-run listener: copy_logs_to_upload_dir 15:23:59 INFO - Copying logs to upload dir... 15:23:59 INFO - mkdir: /builds/slave/test/build/upload/logs 15:23:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.367895 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-19 15:23:58.430682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 15:23:58.433845) ========= 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=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d900879fdabbec39e26e17ff604f6bd56ceac5d81b02dd7a366cbb6e5fc0ed47f7bb7fd7c7e1bb72a2379c992ec09c019fc3ff71d219162e1e6bc6b9e9324b90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0272b9f07c14a0f546b49a98b19927e69f3f92275feb795f50952f50a4587e41e2b8e5a898d6091008297bcce2f9f32105c3f742d8d36260b2ecbcf244d952ed"} build_url:https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/QvU8M0SpQ-eV8bqAUSwkaQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d900879fdabbec39e26e17ff604f6bd56ceac5d81b02dd7a366cbb6e5fc0ed47f7bb7fd7c7e1bb72a2379c992ec09c019fc3ff71d219162e1e6bc6b9e9324b90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0272b9f07c14a0f546b49a98b19927e69f3f92275feb795f50952f50a4587e41e2b8e5a898d6091008297bcce2f9f32105c3f742d8d36260b2ecbcf244d952ed"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 15:23:58.458988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 15:23:58.459329) ========= 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=32c5991c409366f7fec8a718000001d2-1453243576.348356-1528279993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 15:23:58.544458) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 15:23:58.545027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 15:23:58.545349) ========= ========= Total master_lag: 0.33 =========