builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1452985935.98 results: success (0) buildid: 20160116142922 builduid: f46e5698d90541a7b3c5469fcd500b9b revision: c539267331fb152e9d196cf2bedbd0184c71afb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:15.979913) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:15.980405) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:15.980746) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006344 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.038496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.038890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.062840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.063416) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.115218) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.115614) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.116048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.116622) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-16 15:12:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.5M=0s 2016-01-16 15:12:16 (25.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.298981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.299352) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017968 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:16.363379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-16 15:12:16.363735) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c539267331fb152e9d196cf2bedbd0184c71afb8 --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 c539267331fb152e9d196cf2bedbd0184c71afb8 --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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-16 15:12:16,505 truncating revision to first 12 chars 2016-01-16 15:12:16,505 Setting DEBUG logging. 2016-01-16 15:12:16,505 attempt 1/10 2016-01-16 15:12:16,505 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c539267331fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-16 15:12:17,575 unpacking tar archive at: fx-team-c539267331fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.379937 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-16 15:12:17.757588) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:17.757973) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004695 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:17.809654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:17.809994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:17.820738) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:17.821039) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 15:12:17.821446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2016-01-16 15:12:17.821778) ========= /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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:12:18 INFO - MultiFileLogger online at 20160116 15:12:18 in /builds/slave/test 15:12:18 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:12:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:12:18 INFO - {'append_to_log': False, 15:12:18 INFO - 'base_work_dir': '/builds/slave/test', 15:12:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:12:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:12:18 INFO - 'branch': 'Fx-Team-Non-PGO', 15:12:18 INFO - 'buildbot_json_path': 'buildprops.json', 15:12:18 INFO - 'config_files': ('talos/linux_config.py',), 15:12:18 INFO - 'default_actions': ('clobber', 15:12:18 INFO - 'read-buildbot-config', 15:12:18 INFO - 'download-and-extract', 15:12:18 INFO - 'populate-webroot', 15:12:18 INFO - 'create-virtualenv', 15:12:18 INFO - 'install', 15:12:18 INFO - 'run-tests'), 15:12:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:12:18 INFO - 'download_minidump_stackwalk': True, 15:12:18 INFO - 'download_symbols': 'ondemand', 15:12:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:12:18 INFO - 'tooltool.py': '/tools/tooltool.py', 15:12:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:12:18 INFO - '/tools/misc-python/virtualenv.py')}, 15:12:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:12:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:12:18 INFO - 'installer_path': 'installer.exe', 15:12:18 INFO - 'log_level': 'info', 15:12:18 INFO - 'log_name': 'talos', 15:12:18 INFO - 'log_to_console': True, 15:12:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:12:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:12:18 INFO - 'opt_config_files': (), 15:12:18 INFO - 'pip_index': False, 15:12:18 INFO - 'sps_profile': False, 15:12:18 INFO - 'sps_profile_interval': 0, 15:12:18 INFO - 'suite': 'dromaeojs-e10s', 15:12:18 INFO - 'system_bits': '32', 15:12:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:12:18 INFO - 'title': 'talos-linux64-ix-002', 15:12:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:12:18 INFO - 'use_talos_json': True, 15:12:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:12:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:12:18 INFO - 'work_dir': 'build'} 15:12:18 INFO - ##### 15:12:18 INFO - ##### Running clobber step. 15:12:18 INFO - ##### 15:12:18 INFO - Running pre-action listener: _resource_record_pre_action 15:12:18 INFO - Running main action method: clobber 15:12:18 INFO - rmtree: /builds/slave/test/build 15:12:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:12:18 INFO - Running post-action listener: _resource_record_post_action 15:12:18 INFO - ##### 15:12:18 INFO - ##### Running read-buildbot-config step. 15:12:18 INFO - ##### 15:12:18 INFO - Running pre-action listener: _resource_record_pre_action 15:12:18 INFO - Running main action method: read_buildbot_config 15:12:18 INFO - Using buildbot properties: 15:12:18 INFO - { 15:12:18 INFO - "project": "", 15:12:18 INFO - "product": "firefox", 15:12:18 INFO - "script_repo_revision": "production", 15:12:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:12:18 INFO - "repository": "", 15:12:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:12:18 INFO - "buildid": "20160116142922", 15:12:18 INFO - "pgo_build": "False", 15:12:18 INFO - "basedir": "/builds/slave/test", 15:12:18 INFO - "buildnumber": 655, 15:12:18 INFO - "slavename": "talos-linux64-ix-002", 15:12:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:12:18 INFO - "platform": "ubuntu64_hw", 15:12:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:12:18 INFO - "branch": "fx-team", 15:12:18 INFO - "repo_path": "integration/fx-team", 15:12:18 INFO - "revision": "c539267331fb152e9d196cf2bedbd0184c71afb8", 15:12:18 INFO - "stage_platform": "linux64", 15:12:18 INFO - "builduid": "f46e5698d90541a7b3c5469fcd500b9b", 15:12:18 INFO - "slavebuilddir": "test" 15:12:18 INFO - } 15:12:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:12:18 INFO - Running post-action listener: _resource_record_post_action 15:12:18 INFO - ##### 15:12:18 INFO - ##### Running download-and-extract step. 15:12:18 INFO - ##### 15:12:18 INFO - Running pre-action listener: _resource_record_pre_action 15:12:18 INFO - Running main action method: download_and_extract 15:12:18 INFO - mkdir: /builds/slave/test/build/tests 15:12: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:12:18 INFO - https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:12:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/test_packages.json 15:12:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/test_packages.json 15:12:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:12:23 INFO - Downloaded 1448 bytes. 15:12:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:12:23 INFO - Using the following test package requirements: 15:12:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:12:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:12:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:23 INFO - u'jsshell-linux-x86_64.zip'], 15:12:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:12:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:12:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:12:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:12:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:12:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:23 INFO - https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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:12:25 INFO - Downloaded 21172780 bytes. 15:12:25 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:12:25 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:12:26 INFO - Return code: 0 15:12:26 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:12:26 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:12:26 INFO - https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:12:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:12:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:12:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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:12:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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:12:26 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:12:26 INFO - Running command: ['nslookup', u'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 15:12:26 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 15:12:26 INFO - Server: 10.26.75.40 15:12:26 INFO - Address: 10.26.75.40#53 15:12:26 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 15:12:26 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 15:12:26 INFO - Address: 10.26.48.46 15:12:26 INFO - Return code: 0 15:12:26 INFO - retry: attempt #1 caught exception: 15:12:26 INFO - retry: Failed, sleeping 30 seconds before retrying 15:12:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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 #2 15:13:00 INFO - Downloaded 21172780 bytes. 15:13:00 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:13:00 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:13:01 INFO - Return code: 0 15:13: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:13:01 INFO - https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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:13:03 INFO - Downloaded 11132144 bytes. 15:13:03 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:13:03 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:13:04 INFO - Return code: 0 15:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:04 INFO - https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGEWIVpDRXmT4wlvT7omnw/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:13:07 INFO - Downloaded 54129190 bytes. 15:13:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:07 INFO - mkdir: /builds/slave/test/properties 15:13:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:07 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:07 INFO - Contents: 15:13:07 INFO - build_url:https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:07 INFO - Running post-action listener: _resource_record_post_action 15:13:07 INFO - Running post-action listener: set_extra_try_arguments 15:13:07 INFO - ##### 15:13:07 INFO - ##### Running populate-webroot step. 15:13:07 INFO - ##### 15:13:07 INFO - Running pre-action listener: _resource_record_pre_action 15:13:07 INFO - Running main action method: populate_webroot 15:13:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:07 INFO - '--tppagecycles', 15:13:07 INFO - '7'], 15:13:07 INFO - 'tests': ['tsvgm']}}, 15:13:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:13:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:13:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:13:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:07 INFO - 'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:07 INFO - 'tests': ['damp', 'tps']}, 15:13:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:07 INFO - 'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['damp', 'tps']}, 15:13:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:13:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:07 INFO - 'other': {'tests': ['a11yr', 15:13:07 INFO - 'ts_paint', 15:13:07 INFO - 'tpaint', 15:13:07 INFO - 'sessionrestore', 15:13:07 INFO - 'sessionrestore_no_auto_restore']}, 15:13:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['a11yr', 15:13:07 INFO - 'ts_paint', 15:13:07 INFO - 'tpaint', 15:13:07 INFO - 'sessionrestore', 15:13:07 INFO - 'sessionrestore_no_auto_restore']}, 15:13:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['a11yr', 15:13:07 INFO - 'ts_paint', 15:13:07 INFO - 'tpaint', 15:13:07 INFO - 'sessionrestore', 15:13:07 INFO - 'sessionrestore_no_auto_restore']}, 15:13:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['a11yr', 15:13:07 INFO - 'ts_paint', 15:13:07 INFO - 'tpaint', 15:13:07 INFO - 'sessionrestore', 15:13:07 INFO - 'sessionrestore_no_auto_restore']}, 15:13:07 INFO - 'other_l64': {'tests': ['a11yr', 15:13:07 INFO - 'ts_paint', 15:13:07 INFO - 'tpaint', 15:13:07 INFO - 'sessionrestore', 15:13:07 INFO - 'sessionrestore_no_auto_restore']}, 15:13:07 INFO - 'other_nol64': {'tests': ['a11yr', 15:13:07 INFO - 'ts_paint', 15:13:07 INFO - 'tpaint', 15:13:07 INFO - 'sessionrestore', 15:13:07 INFO - 'sessionrestore_no_auto_restore']}, 15:13:07 INFO - 'svgr': {'tests': ['tsvgx', 15:13:07 INFO - 'tsvgr_opacity', 15:13:07 INFO - 'tart', 15:13:07 INFO - 'tscrollx', 15:13:07 INFO - 'cart']}, 15:13:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['tsvgx', 15:13:07 INFO - 'tsvgr_opacity', 15:13:07 INFO - 'tart', 15:13:07 INFO - 'tscrollx', 15:13:07 INFO - 'cart']}, 15:13:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:07 INFO - 'tests': ['tp5o']}, 15:13:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:07 INFO - 'talos_options': ['--e10s'], 15:13:07 INFO - 'tests': ['tp5o']}, 15:13:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:07 INFO - 'talos_options': ['--xperf_path', 15:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:07 INFO - 'tests': ['tp5n']}, 15:13:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:07 INFO - 'talos_options': ['--e10s', 15:13:07 INFO - '--xperf_path', 15:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:07 INFO - 'tests': ['tp5n']}}, 15:13:07 INFO - 'talos.zip': {'path': '', 15:13:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:07 INFO - Running post-action listener: _resource_record_post_action 15:13:07 INFO - ##### 15:13:07 INFO - ##### Running create-virtualenv step. 15:13:07 INFO - ##### 15:13:07 INFO - Running pre-action listener: _resource_record_pre_action 15:13:07 INFO - Running main action method: create_virtualenv 15:13:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:07 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:13:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:07 INFO - Using real prefix '/usr' 15:13:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:09 INFO - Installing pip.................done. 15:13:09 INFO - Return code: 0 15:13:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13: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:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:09 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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:09 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:13:09 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:13:09 INFO - Using env: {'DISPLAY': ':0', 15:13:09 INFO - 'HOME': '/home/cltbld', 15:13:09 INFO - 'LANG': 'en_US.UTF-8', 15:13:09 INFO - 'LANGUAGE': 'en_US:en', 15:13:09 INFO - 'LOGNAME': 'cltbld', 15:13:09 INFO - 'MAIL': '/var/mail/cltbld', 15:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:09 INFO - 'MOZ_NO_REMOTE': '1', 15:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:09 INFO - 'NO_EM_RESTART': '1', 15:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:09 INFO - 'PWD': '/builds/slave/test', 15:13:09 INFO - 'SHELL': '/bin/bash', 15:13:09 INFO - 'SHLVL': '1', 15:13:09 INFO - 'TERM': 'linux', 15:13:09 INFO - 'TMOUT': '86400', 15:13:09 INFO - 'USER': 'cltbld', 15:13:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:09 INFO - '_': '/tools/buildbot/bin/python'} 15:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:10 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:13:10 INFO - Cleaning up... 15:13:10 INFO - Return code: 0 15:13:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:10 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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:10 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:13:10 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:13:10 INFO - Using env: {'DISPLAY': ':0', 15:13:10 INFO - 'HOME': '/home/cltbld', 15:13:10 INFO - 'LANG': 'en_US.UTF-8', 15:13:10 INFO - 'LANGUAGE': 'en_US:en', 15:13:10 INFO - 'LOGNAME': 'cltbld', 15:13:10 INFO - 'MAIL': '/var/mail/cltbld', 15:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:10 INFO - 'MOZ_NO_REMOTE': '1', 15:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:10 INFO - 'NO_EM_RESTART': '1', 15:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:10 INFO - 'PWD': '/builds/slave/test', 15:13:10 INFO - 'SHELL': '/bin/bash', 15:13:10 INFO - 'SHLVL': '1', 15:13:10 INFO - 'TERM': 'linux', 15:13:10 INFO - 'TMOUT': '86400', 15:13:10 INFO - 'USER': 'cltbld', 15:13:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:10 INFO - '_': '/tools/buildbot/bin/python'} 15:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:10 INFO - Downloading/unpacking psutil>=0.7.1 15:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:13:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:13:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:12 INFO - Installing collected packages: psutil 15:13:12 INFO - Running setup.py install for psutil 15:13:12 INFO - building 'psutil._psutil_linux' extension 15:13:12 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:13:12 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:13:12 INFO - building 'psutil._psutil_posix' extension 15:13:12 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:13:12 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:13:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:12 INFO - Successfully installed psutil 15:13:12 INFO - Cleaning up... 15:13:13 INFO - Return code: 0 15:13:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:13:13 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:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:13 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:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:13 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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:13 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:13:13 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:13:13 INFO - Using env: {'DISPLAY': ':0', 15:13:13 INFO - 'HOME': '/home/cltbld', 15:13:13 INFO - 'LANG': 'en_US.UTF-8', 15:13:13 INFO - 'LANGUAGE': 'en_US:en', 15:13:13 INFO - 'LOGNAME': 'cltbld', 15:13:13 INFO - 'MAIL': '/var/mail/cltbld', 15:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:13 INFO - 'MOZ_NO_REMOTE': '1', 15:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:13 INFO - 'NO_EM_RESTART': '1', 15:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:13 INFO - 'PWD': '/builds/slave/test', 15:13:13 INFO - 'SHELL': '/bin/bash', 15:13:13 INFO - 'SHLVL': '1', 15:13:13 INFO - 'TERM': 'linux', 15:13:13 INFO - 'TMOUT': '86400', 15:13:13 INFO - 'USER': 'cltbld', 15:13:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:13 INFO - '_': '/tools/buildbot/bin/python'} 15:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:13: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:13: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:13: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:13: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:13: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:13: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:13:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:13:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:13:15 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:13:15 INFO - Installing collected packages: mozsystemmonitor 15:13:15 INFO - Running setup.py install for mozsystemmonitor 15:13:15 INFO - Successfully installed mozsystemmonitor 15:13:15 INFO - Cleaning up... 15:13:15 INFO - Return code: 0 15:13:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:13: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:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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', '--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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:15 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:13:15 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:13:15 INFO - Using env: {'DISPLAY': ':0', 15:13:15 INFO - 'HOME': '/home/cltbld', 15:13:15 INFO - 'LANG': 'en_US.UTF-8', 15:13:15 INFO - 'LANGUAGE': 'en_US:en', 15:13:15 INFO - 'LOGNAME': 'cltbld', 15:13:15 INFO - 'MAIL': '/var/mail/cltbld', 15:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:15 INFO - 'MOZ_NO_REMOTE': '1', 15:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:15 INFO - 'NO_EM_RESTART': '1', 15:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:15 INFO - 'PWD': '/builds/slave/test', 15:13:15 INFO - 'SHELL': '/bin/bash', 15:13:15 INFO - 'SHLVL': '1', 15:13:15 INFO - 'TERM': 'linux', 15:13:15 INFO - 'TMOUT': '86400', 15:13:15 INFO - 'USER': 'cltbld', 15:13:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:15 INFO - '_': '/tools/buildbot/bin/python'} 15:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:15 INFO - Downloading/unpacking blobuploader==1.2.4 15:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:17 INFO - Downloading blobuploader-1.2.4.tar.gz 15:13:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:13:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:13: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:13: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:13: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:13: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:13: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:13: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:13:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:13:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:13: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:13: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:13: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:13: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:13: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:13: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:13:18 INFO - Downloading docopt-0.6.1.tar.gz 15:13:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:13:18 INFO - Installing collected packages: blobuploader, requests, docopt 15:13:18 INFO - Running setup.py install for blobuploader 15:13:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:13:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:13:18 INFO - Running setup.py install for requests 15:13:19 INFO - Running setup.py install for docopt 15:13:19 INFO - Successfully installed blobuploader requests docopt 15:13:19 INFO - Cleaning up... 15:13:19 INFO - Return code: 0 15:13:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:19 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:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:19 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:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:19 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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:19 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:13:19 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:13:19 INFO - Using env: {'DISPLAY': ':0', 15:13:19 INFO - 'HOME': '/home/cltbld', 15:13:19 INFO - 'LANG': 'en_US.UTF-8', 15:13:19 INFO - 'LANGUAGE': 'en_US:en', 15:13:19 INFO - 'LOGNAME': 'cltbld', 15:13:19 INFO - 'MAIL': '/var/mail/cltbld', 15:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:19 INFO - 'MOZ_NO_REMOTE': '1', 15:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:19 INFO - 'NO_EM_RESTART': '1', 15:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:19 INFO - 'PWD': '/builds/slave/test', 15:13:19 INFO - 'SHELL': '/bin/bash', 15:13:19 INFO - 'SHLVL': '1', 15:13:19 INFO - 'TERM': 'linux', 15:13:19 INFO - 'TMOUT': '86400', 15:13:19 INFO - 'USER': 'cltbld', 15:13:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:19 INFO - '_': '/tools/buildbot/bin/python'} 15:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:19 INFO - Running setup.py (path:/tmp/pip-606M_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:19 INFO - Running setup.py (path:/tmp/pip-iQwVQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:19 INFO - Running setup.py (path:/tmp/pip-iBBv2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:19 INFO - Running setup.py (path:/tmp/pip-re35Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:19 INFO - Running setup.py (path:/tmp/pip-zoVEwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:19 INFO - Running setup.py (path:/tmp/pip-DzvmXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:19 INFO - Running setup.py (path:/tmp/pip-BxTsvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:20 INFO - Running setup.py (path:/tmp/pip-HRzKp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:20 INFO - Running setup.py (path:/tmp/pip-12g7TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:20 INFO - Running setup.py (path:/tmp/pip-JHXD7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:20 INFO - Running setup.py (path:/tmp/pip-HAQpsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:20 INFO - Running setup.py (path:/tmp/pip-sm2jx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:20 INFO - Running setup.py (path:/tmp/pip-lGrgL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:20 INFO - Running setup.py (path:/tmp/pip-KcDWTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:20 INFO - Running setup.py (path:/tmp/pip-7a8VOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:20 INFO - Running setup.py (path:/tmp/pip-Ntqeqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:20 INFO - Running setup.py (path:/tmp/pip-ZQxB1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:13:20 INFO - Running setup.py install for manifestparser 15:13:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:13:20 INFO - Running setup.py install for mozcrash 15:13:20 INFO - Running setup.py install for mozdebug 15:13:21 INFO - Running setup.py install for mozdevice 15:13:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Running setup.py install for mozfile 15:13:21 INFO - Running setup.py install for mozhttpd 15:13:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Running setup.py install for mozinfo 15:13:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Running setup.py install for mozInstall 15:13:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Running setup.py install for mozleak 15:13:21 INFO - Running setup.py install for mozlog 15:13:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Running setup.py install for moznetwork 15:13:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:13:21 INFO - Running setup.py install for mozprocess 15:13:21 INFO - Running setup.py install for mozprofile 15:13:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:13:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:13:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:13:22 INFO - Running setup.py install for mozrunner 15:13:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:13:22 INFO - Running setup.py install for mozscreenshot 15:13:22 INFO - Running setup.py install for moztest 15:13:22 INFO - Running setup.py install for mozversion 15:13:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:13:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:13:22 INFO - Cleaning up... 15:13:22 INFO - Return code: 0 15:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:22 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:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:22 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:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:22 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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:22 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:13:22 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:13:22 INFO - Using env: {'DISPLAY': ':0', 15:13:22 INFO - 'HOME': '/home/cltbld', 15:13:22 INFO - 'LANG': 'en_US.UTF-8', 15:13:22 INFO - 'LANGUAGE': 'en_US:en', 15:13:22 INFO - 'LOGNAME': 'cltbld', 15:13:22 INFO - 'MAIL': '/var/mail/cltbld', 15:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:22 INFO - 'MOZ_NO_REMOTE': '1', 15:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:22 INFO - 'NO_EM_RESTART': '1', 15:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:22 INFO - 'PWD': '/builds/slave/test', 15:13:22 INFO - 'SHELL': '/bin/bash', 15:13:22 INFO - 'SHLVL': '1', 15:13:22 INFO - 'TERM': 'linux', 15:13:22 INFO - 'TMOUT': '86400', 15:13:22 INFO - 'USER': 'cltbld', 15:13:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:22 INFO - '_': '/tools/buildbot/bin/python'} 15:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:22 INFO - Running setup.py (path:/tmp/pip-K59C6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:22 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:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:22 INFO - Running setup.py (path:/tmp/pip-U0lnRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:22 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:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:22 INFO - Running setup.py (path:/tmp/pip-6V4dDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:22 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:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:22 INFO - Running setup.py (path:/tmp/pip-TB3u7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:22 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:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:22 INFO - Running setup.py (path:/tmp/pip-1hBfdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:23 INFO - Running setup.py (path:/tmp/pip-Us8KXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:23 INFO - Running setup.py (path:/tmp/pip-Em9wSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:23 INFO - Running setup.py (path:/tmp/pip-yQ7jcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:23 INFO - Running setup.py (path:/tmp/pip-EuT5QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:23 INFO - Running setup.py (path:/tmp/pip-ytNyGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:23 INFO - Running setup.py (path:/tmp/pip-WCicml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:23 INFO - Running setup.py (path:/tmp/pip-UgSe1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:23 INFO - Running setup.py (path:/tmp/pip-4mL3aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:23 INFO - Running setup.py (path:/tmp/pip-BfWp9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:23 INFO - Running setup.py (path:/tmp/pip-AvRiRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:23 INFO - Running setup.py (path:/tmp/pip-rwMUm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:23 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:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:23 INFO - Running setup.py (path:/tmp/pip-DCpmnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 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:13:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:25 INFO - Downloading blessings-1.5.1.tar.gz 15:13:25 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:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:13:25 INFO - Installing collected packages: blessings 15:13:25 INFO - Running setup.py install for blessings 15:13:25 INFO - Successfully installed blessings 15:13:25 INFO - Cleaning up... 15:13:25 INFO - Return code: 0 15:13:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:13:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:26 INFO - Reading from file tmpfile_stdout 15:13:26 INFO - Current package versions: 15:13:26 INFO - argparse == 1.2.1 15:13:26 INFO - blessings == 1.5.1 15:13:26 INFO - blobuploader == 1.2.4 15:13:26 INFO - docopt == 0.6.1 15:13:26 INFO - manifestparser == 1.1 15:13:26 INFO - mozInstall == 1.12 15:13:26 INFO - mozcrash == 0.16 15:13:26 INFO - mozdebug == 0.1 15:13:26 INFO - mozdevice == 0.48 15:13:26 INFO - mozfile == 1.2 15:13:26 INFO - mozhttpd == 0.7 15:13:26 INFO - mozinfo == 0.9 15:13:26 INFO - mozleak == 0.1 15:13:26 INFO - mozlog == 3.1 15:13:26 INFO - moznetwork == 0.27 15:13:26 INFO - mozprocess == 0.22 15:13:26 INFO - mozprofile == 0.28 15:13:26 INFO - mozrunner == 6.11 15:13:26 INFO - mozscreenshot == 0.1 15:13:26 INFO - mozsystemmonitor == 0.0 15:13:26 INFO - moztest == 0.7 15:13:26 INFO - mozversion == 1.4 15:13:26 INFO - psutil == 3.1.1 15:13:26 INFO - requests == 1.2.3 15:13:26 INFO - wsgiref == 0.1.2 15:13:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:26 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:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:26 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:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:26 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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:26 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:13:26 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:13:26 INFO - Using env: {'DISPLAY': ':0', 15:13:26 INFO - 'HOME': '/home/cltbld', 15:13:26 INFO - 'LANG': 'en_US.UTF-8', 15:13:26 INFO - 'LANGUAGE': 'en_US:en', 15:13:26 INFO - 'LOGNAME': 'cltbld', 15:13:26 INFO - 'MAIL': '/var/mail/cltbld', 15:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:26 INFO - 'MOZ_NO_REMOTE': '1', 15:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:26 INFO - 'NO_EM_RESTART': '1', 15:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:26 INFO - 'PWD': '/builds/slave/test', 15:13:26 INFO - 'SHELL': '/bin/bash', 15:13:26 INFO - 'SHLVL': '1', 15:13:26 INFO - 'TERM': 'linux', 15:13:26 INFO - 'TMOUT': '86400', 15:13:26 INFO - 'USER': 'cltbld', 15:13:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:26 INFO - '_': '/tools/buildbot/bin/python'} 15:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:26 INFO - Cleaning up... 15:13:26 INFO - Return code: 0 15:13:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:13:26 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:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:26 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:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:26 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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:26 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:13:26 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:13:26 INFO - Using env: {'DISPLAY': ':0', 15:13:26 INFO - 'HOME': '/home/cltbld', 15:13:26 INFO - 'LANG': 'en_US.UTF-8', 15:13:26 INFO - 'LANGUAGE': 'en_US:en', 15:13:26 INFO - 'LOGNAME': 'cltbld', 15:13:26 INFO - 'MAIL': '/var/mail/cltbld', 15:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:26 INFO - 'MOZ_NO_REMOTE': '1', 15:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:26 INFO - 'NO_EM_RESTART': '1', 15:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:26 INFO - 'PWD': '/builds/slave/test', 15:13:26 INFO - 'SHELL': '/bin/bash', 15:13:26 INFO - 'SHLVL': '1', 15:13:26 INFO - 'TERM': 'linux', 15:13:26 INFO - 'TMOUT': '86400', 15:13:26 INFO - 'USER': 'cltbld', 15:13:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:26 INFO - '_': '/tools/buildbot/bin/python'} 15:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:26 INFO - Downloading/unpacking jsonschema 15:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:26 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:13:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:13:28 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:13:28 INFO - Downloading/unpacking functools32 (from jsonschema) 15:13:28 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:13:28 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:13:28 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:13:28 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:13:28 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:13:28 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:13:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:13:28 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:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:13:28 INFO - warning: no files found matching '*.txt' 15:13:28 INFO - no previously-included directories found matching 'build' 15:13:28 INFO - no previously-included directories found matching 'dist' 15:13:28 INFO - no previously-included directories found matching '.git*' 15:13:28 INFO - Installing collected packages: jsonschema, functools32 15:13:28 INFO - Running setup.py install for functools32 15:13:28 INFO - warning: no files found matching '*.txt' 15:13:28 INFO - no previously-included directories found matching 'build' 15:13:28 INFO - no previously-included directories found matching 'dist' 15:13:28 INFO - no previously-included directories found matching '.git*' 15:13:28 INFO - Successfully installed jsonschema functools32 15:13:28 INFO - Cleaning up... 15:13:28 INFO - Return code: 0 15:13:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:28 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 0x7f8dd0852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', '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:13:28 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:13:28 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:13:28 INFO - Using env: {'DISPLAY': ':0', 15:13:28 INFO - 'HOME': '/home/cltbld', 15:13:28 INFO - 'LANG': 'en_US.UTF-8', 15:13:28 INFO - 'LANGUAGE': 'en_US:en', 15:13:28 INFO - 'LOGNAME': 'cltbld', 15:13:28 INFO - 'MAIL': '/var/mail/cltbld', 15:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:28 INFO - 'MOZ_NO_REMOTE': '1', 15:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:28 INFO - 'NO_EM_RESTART': '1', 15:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:28 INFO - 'PWD': '/builds/slave/test', 15:13:28 INFO - 'SHELL': '/bin/bash', 15:13:28 INFO - 'SHLVL': '1', 15:13:28 INFO - 'TERM': 'linux', 15:13:28 INFO - 'TMOUT': '86400', 15:13:28 INFO - 'USER': 'cltbld', 15:13:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:28 INFO - '_': '/tools/buildbot/bin/python'} 15:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:28 INFO - Downloading/unpacking flake8 15:13:28 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:13:28 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:13:28 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:13:28 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:13:28 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:13:28 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:13:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:13:30 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:13:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:13:30 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:13:30 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:13:30 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:13:30 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:13:30 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:13:30 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:13:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:13:30 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:13:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:13:30 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:13:30 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:13:30 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:13:30 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:13:30 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:13:30 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:13:30 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:13:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:13:30 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:13:30 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:13:30 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:13:30 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:13:30 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:13:30 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:13:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:13:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:13:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:13:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:13:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:13:31 INFO - no previously-included directories found matching 'docs/_build' 15:13:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:13:31 INFO - Running setup.py install for pep8 15:13:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:13:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:13:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:13:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:13:31 INFO - no previously-included directories found matching 'docs/_build' 15:13:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:13:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:13:31 INFO - Cleaning up... 15:13:31 INFO - Return code: 0 15:13:31 INFO - Running post-action listener: _resource_record_post_action 15:13:31 INFO - Running post-action listener: _start_resource_monitoring 15:13:31 INFO - Starting resource monitoring. 15:13:31 INFO - ##### 15:13:31 INFO - ##### Running install step. 15:13:31 INFO - ##### 15:13:31 INFO - Running pre-action listener: _resource_record_pre_action 15:13:31 INFO - Running main action method: install 15:13:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:31 INFO - Reading from file tmpfile_stdout 15:13:31 INFO - Detecting whether we're running mozinstall >=1.0... 15:13:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:13:31 INFO - Reading from file tmpfile_stdout 15:13:31 INFO - Output received: 15:13:31 INFO - Usage: mozinstall [options] installer 15:13:31 INFO - Options: 15:13:31 INFO - -h, --help show this help message and exit 15:13:31 INFO - -d DEST, --destination=DEST 15:13:31 INFO - Directory to install application into. [default: 15:13:31 INFO - "/builds/slave/test"] 15:13:31 INFO - --app=APP Application being installed. [default: firefox] 15:13:31 INFO - mkdir: /builds/slave/test/build/application 15:13:31 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:13:31 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:13:47 INFO - Reading from file tmpfile_stdout 15:13:47 INFO - Output received: 15:13:47 INFO - /builds/slave/test/build/application/firefox/firefox 15:13:47 INFO - Running post-action listener: _resource_record_post_action 15:13:47 INFO - ##### 15:13:47 INFO - ##### Running run-tests step. 15:13:47 INFO - ##### 15:13:47 INFO - Running pre-action listener: _resource_record_pre_action 15:13:47 INFO - Running main action method: run_tests 15:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:13:47 INFO - Python 2.7.3 15:13:47 INFO - Return code: 0 15:13:47 INFO - grabbing minidump binary from tooltool 15:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:47 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 0x1d1a3d0>, '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 0x1c85ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c86360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:13:47 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:13:47 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:13:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:13:47 INFO - Return code: 0 15:13:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:13:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:13:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:13:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:13:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:13:48 INFO - Return code: 0 15:13:48 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/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:13:48 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/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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:13:48 INFO - Using env: {'DISPLAY': ':0', 15:13:48 INFO - 'HOME': '/home/cltbld', 15:13:48 INFO - 'LANG': 'en_US.UTF-8', 15:13:48 INFO - 'LANGUAGE': 'en_US:en', 15:13:48 INFO - 'LOGNAME': 'cltbld', 15:13:48 INFO - 'MAIL': '/var/mail/cltbld', 15:13:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:13:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:48 INFO - 'MOZ_NO_REMOTE': '1', 15:13:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:48 INFO - 'NO_EM_RESTART': '1', 15:13:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:48 INFO - 'PWD': '/builds/slave/test', 15:13:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:13:48 INFO - 'SHELL': '/bin/bash', 15:13:48 INFO - 'SHLVL': '1', 15:13:48 INFO - 'TERM': 'linux', 15:13:48 INFO - 'TMOUT': '86400', 15:13:48 INFO - 'USER': 'cltbld', 15:13:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069', 15:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:48 INFO - '_': '/tools/buildbot/bin/python'} 15:13:48 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/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:13:48 INFO - mozversion application_buildid: 20160116142922 15:13:48 INFO - mozversion application_changeset: c539267331fb152e9d196cf2bedbd0184c71afb8 15:13:48 INFO - mozversion application_display_name: Nightly 15:13:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:13:48 INFO - mozversion application_name: Firefox 15:13:48 INFO - mozversion application_remotingname: firefox 15:13:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:13:48 INFO - mozversion application_vendor: Mozilla 15:13:48 INFO - mozversion application_version: 46.0a1 15:13:48 INFO - mozversion platform_buildid: 20160116142922 15:13:48 INFO - mozversion platform_changeset: c539267331fb152e9d196cf2bedbd0184c71afb8 15:13:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:13:48 INFO - mozversion platform_version: 46.0a1 15:13:48 INFO - using testdate: 1452986028 15:13:48 INFO - actual date: 1452986028 15:13:48 INFO - starting webserver on 'localhost:58493' 15:13:48 INFO - SUITE-START | Running 3 tests 15:13:48 INFO - TEST-START | dromaeo_css 15:13:48 INFO - operating with platform_type : linux_ 15:13:48 INFO - Initialising browser for dromaeo_css test... 15:13:48 INFO - TEST-INFO | started process 5496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBH28My/profile http://localhost:58493/getInfo.html) 15:13:52 INFO - PROCESS | 5496 | 15:13:52 INFO - PROCESS | 5496 | (process:5577): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:53 INFO - PROCESS | 5496 | __metrics Screen width/height:1600/1200 15:13:53 INFO - PROCESS | 5496 | colorDepth:24 15:13:53 INFO - PROCESS | 5496 | Browser inner width/height: 1024/697 15:13:53 INFO - PROCESS | 5496 | __metrics 15:13:53 INFO - PROCESS | 5496 | 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:13:54 INFO - TEST-INFO | 5496: exit 0 15:13:54 INFO - Browser initialized. 15:13:54 INFO - Running cycle 1/1 for dromaeo_css test... 15:13:54 INFO - TEST-INFO | started process 5626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBH28My/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:56 INFO - PROCESS | 5626 | 15:13:56 INFO - PROCESS | 5626 | (process:5681): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:14:06 INFO - PROCESS | 5626 | RSS: Main: 151134208 15:14:06 INFO - PROCESS | 5626 | 15:14:56 INFO - PROCESS | 5626 | 1452986096392 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:17:07 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58493/tests/dromaeo/cssquery-ext.html) 15:17:08 INFO - PROCESS | 5626 | RSS: Main: 154214400 15:17:08 INFO - PROCESS | 5626 | 15:20:10 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-ext.html (next: http://localhost:58493/tests/dromaeo/cssquery-jquery.html) 15:20:11 INFO - PROCESS | 5626 | RSS: Main: 154300416 15:20:11 INFO - PROCESS | 5626 | 15:23:13 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58493/tests/dromaeo/cssquery-mootools.html) 15:23:13 INFO - PROCESS | 5626 | RSS: Main: 152924160 15:23:13 INFO - PROCESS | 5626 | 15:26:15 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58493/tests/dromaeo/cssquery-prototype.html) 15:26:16 INFO - PROCESS | 5626 | RSS: Main: 151478272 15:26:16 INFO - PROCESS | 5626 | 15:29:18 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58493/tests/dromaeo/cssquery-yui.html) 15:29:19 INFO - PROCESS | 5626 | RSS: Main: 150749184 15:29:19 INFO - PROCESS | 5626 | 15:32:21 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-yui.html (next: http://localhost:58493/tests/dromaeo/cssquery-dojo.html) 15:32:22 INFO - PROCESS | 5626 | RSS: Main: 153980928 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - PROCESS | 5626 | __start_tp_report 15:32:22 INFO - PROCESS | 5626 | _x_x_mozilla_page_load 15:32:22 INFO - PROCESS | 5626 | _x_x_mozilla_page_load_details 15:32:22 INFO - PROCESS | 5626 | |i|pagename|runs| 15:32:22 INFO - PROCESS | 5626 | |0;dojo.html;2631.4342416380473;2675.3712877473804;2700.1494529223305;2701.7163197864224;2719.225020869052;4373.868783936479;4483.86548403548;4484.506704262532;4527.501974782771;4547.909041819165;4461.955380446195;4493.685442019052;4502.23462011458;4560.657950653706;4562.156001139791;4169.541350451448;4219.430376899126;4225.366195070733;4293.613574778269;4300.849470268541;4032.2540330039037;4213.5786421357925;4250.171216612762;4253.553376895427;4272.615464608185;4112.465379500646;4128.401381799652;4180.602842729936;4184.142250838601;4239.385289133058;4200.243956087903;4206.495220573551;4210.578942105795;4213.9578604213875;4232.894177645553;4088.468499095128;4159.9376009359885;4172.457580514514;4186.35111557709;4207.51613564441;4387.100644367897;4469.150861336336;4495.595396414338;4519.84180553679;4522.23122069249;4793.089313030548;4802.087603355351;4814.807407703687;4820.8071677132875;4861.465238823726;4707.7881495332795;4785.162596545625;4790.5448982346625;4852.1508735971065;4865.2945322928335;4466.3747075409465;4472.642188624902;4501.122281155143;4521.36700861873;4542.295944128632;4915.311856340115;4922.163232250526;4924.113659541317;4931.852044438672;4972.0801651694555;4638.489766125724;4704.788284527204;4706.811727530929;4737.573618374363;4812.783424745895;4816.349792778;4821.2045012572535;4831.347768051268;4831.589314908272;4864.975675121673;4779.761011949388;4793.376861008047;4796.232602783538;4796.976015119972;4848.369711937426;4649.976750116295;4745.620350371962;4749.786259618326;4782.593479554277;4825.083234185494;4007.8396864125693;4013.779242141652;4022.1151346703678;4031.7984100794843;4051.9392209116886;3539.50446937429;3578.5526809148855;3584.713222942158;3606.026372879308;3616.6021737608844;4122.40225167349;4146.79266036703;4205.927488490415;4208.116295577902;4241.660667146621;4780.904381912343;4834.7824347904425;4844.660873738875;4845.416202451064;4876.024795041006;4049.493813273341;4127.9587204128175;4187.5184353799705;4194.832206711759;4198.223328684203;4236.046889449849;4242.109157076987;4249.150169966019;4326.502452217972;4344.348347747863;4500.572445617661;4518.051209246029;4519.4576650801455;4535.8185672574045;4548.13585418776;4722.055588882168;4765.404324459442;4774.140654682191;4775.594074503706;4810.542998415145;4530.207213737649;4550.317452382169;4568.474625418119;4580.702254353457;4591.724496530219;4779.235322348408;4785;4786.8085276588545;4792.640551958547;4829.444613869309;4681.648876334357;4755.1916174251155;4801.4958429364415;4830.347903033045;4836;4620.514845941262;4673.556012178838;4680.923387620935;4693.0613877224005;4728.0543891221205;4680.297955306732;4704.858854234379;4708.246680531099;4725.031368569366;4749.121412538691;4481.596656300949;4547.431571053618;4552.476465206543;4631.397918270603;4631.976840115778;4720.669553131385;4727.881802954954;4733.242681170997;4739.857804265877;4748.596369308648;4628.652851036253;4629.305604159403;4634.119517291704;4634.165850147006;4665.5101214372 15:32:22 INFO - PROCESS | 5626 | |1;ext.html;479.161467431994;482.1417876180398;489.52516059422345;499.33338992445096;503.30795156659593;24889.12888048919;32398.67601323986;32695.50956735651;32719.67280327196;32759.88781065798;35726.28547429056;36493.452598210984;36580.26839463209;36621.81689091551;36648;7590.582517961496;7757.961210193941;7866.606669666522;7878.054633443995;7881.566513841736;7591.848163036736;7642.808929776745;7696.268854458845;7745.264199901028;7794.532328060306;7725.536467811921;7864.724734634289;7870.960645196795;7874.094479134887;7885.369170466378;7757.379409647215;7800.180980996999;7829.765107046797;7852.254035866641;7861.056673199224;7540.924590754077;7649.847003059963;7700.075990881074;7722.845543089107;7728.111267204287;34442.13894652654;34549.309013819584;34758.304833903436;34765.82617086898;34859.65140348589;2776.6806817215875;2788.9581656275172;3014.1861697341596;3111.5177147542167;3520.6479352064844;26990.730092699214;27076.59385109225;27302.726972730416;27310.317242068908;27529.31176720578;3253.544503769474;3270.4930735735998;3315.8010519368913;3356.345512625039;3416.9487457688156;214616;214770;215930;217454;217502;44472;45488;50083.24875126876;51687.2246916289;52439;45581;45657.31514027226;45689.77155114203;45726.085478290246;45880.3117953231;12532.624021279376;12624.873751262554;12639.87360126387;12730.23618582888;12753.68115797094;9501.619935202514;9524.714258572254;9535.856962145574;9580.856287155699;9618.134367906921;17153;17619.119044047748;17706.46880593584;17796.3771268005;17801;7022.683979220948;7185.209626941032;7208.098987626547;7209.639518024078;7239.601821899846;787.9724209652635;841.9621117049747;895.9104089591119;958.2860768727203;983.5131609853169;25566.616500752505;25735.871320643277;26107.477850442883;26144.8692756535;26303.21090367292;897.4615230861431;912.885889263842;935.8783358163395;938.8216238914721;976.092234222166;13429.529966451128;13493.392797324144;13885.375158117708;13985.3706583204;14254.144751314954;273577;277389;277871;279322;279423;44260.3360949586;44417.33373999393;44450;44461.55538444639;44647;1144.7080994346554;1150.453534571072;1153.3022521374614;1159.913006524514;1295.1710905020793;25410;25577.488450231263;25619.871900640377;25789.742102578733;25927.61108583335;38275.617243827204;38661.22677546489;38738.4189237156;38783.612163878;38835.805820971844;257280;258677;259467;260003;261903;26609.866950665124;27643.170704878885;28308.150755477367;28322;28605.28486787847;33055.50416743799;33066.834665826515;34672.30655386928;35276.64723352836;35536.822315888254;29855.253618659706;30143.698563014088;30591.388172235984;30713.53929691101;30764.230894227825;28104.69870768093;28264.15207543777;28542.857285714268;28584.428311434072;29318.560221596268;28644.283892902844;28837;28899.855500723203;28907.855460723404;29054;26871.462570748867;29075.7092429073;29779.851100744356;31133.532997005517;32414;21781.455463613536;22880.771192287863;22968.770312297333;23040.4239894004;23196.3041108767 15:32:22 INFO - PROCESS | 5626 | |2;jquery.html;328.4627941235021;336.4448659711476;337.52240579579893;341.78638351030605;343.0890984436322;14029.649258768535;14627.26863656817;14899.32953017114;14932.477363292286;15713.371465141381;8758.430702004365;9007.144321289483;10445.529951152197;13856.445742170301;13890.652733681638;4212.052288235138;4212.136512015045;4396.252637051693;4396.846110386137;4413.271810151321;4749.525047495257;4753.928691069636;4760.500147484516;4765.7140571565815;4768.666193366465;3307.3219989902013;3432.433648448003;4599.770011499429;4977.576905962997;5987.341392446828;6160.7535698572;6312.116303717483;6381.425671689523;6386.904196437057;6387.552871298988;6113.113598528189;6124.571280010401;6131.264248290189;6133.601315914451;6137.9079313810325;17825.554361140945;19631.607367852564;20632;20721.481962950897;20761.273355432488;1867.175473643834;1908.1127275816812;1935.4870959195825;2035.8880261585607;2118.851680382374;13025.283609401478;13083.934580327037;13340.533081342106;13603.455861765517;13633.113847599874;1882.1436246507942;1901.7622797150357;1906.5805522785104;1940.4760714607119;1968.9901550492157;52331.73834130843;52683.270071256615;53766.92466150694;54176.72911635417;54656.72671636656;14343.78484322736;14616.123032618078;14637.560873173821;14654.267286635626;14684.85315146835;21708.13167473315;21779.564408711736;21947.231846885283;22031;22037.126844218423;7119.1457025157315;7333.376662983706;7346.11846578414;7352.117745870422;7442.106947166267;5813.82558523245;5842.707864606753;5899.498542623839;5917.289925209003;5926.703664816742;7157.606331651809;7163.253813607873;7279.12650481935;7331.845712464057;7408.555486670709;2924.0350684274563;2935.2074939766144;2953.6898625644426;2956.926076848096;2982.388610334876;319.5207189216176;323.9174010627275;324.4565353033659;328.83886895421074;351.67470090167006;8569.700060497977;8745.169208925143;8857.557122143868;8998.955005224932;9107.726768196964;342.3734565744731;350.556545969349;357.1963083063108;364.6918353990873;365.9012066742018;4863.416390033219;4938.950610493921;5079.619028572872;8477.533735644476;8819.911800882037;276728;283674;457780;463646;464106;40103;54481.1827822583;60308.69845650744;61668;64342.678286608265;1014.2089170446916;1025.8102251083424;1032.2825636182931;1037.1547189040757;1047.2145890582065;13468.124571902796;13605.795913061114;13833.79249311241;13908.582742517741;13953.581392558239;28415.573766393107;29421.411571768873;29759.404811904074;30276.24309392283;30695.2326191847;37783.62216377801;39024.02439939024;39114.80442597769;39273.8036309828;39930.80034599808;5847.736851841592;5881.500072493886;5889.38161493037;5901.380355062656;5915.733791979457;6530.640814755234;8841.646334146562;8989.595468204077;9152.084791521062;9164.312676549418;7965.402594805529;8162.224588664068;8351.498910065415;8489.660413583388;8590.14098590161;8552.144785521647;8576.871346929925;8783.385163038525;8871.157240062184;8987.370884038317;8647;8730.257928076184;8811.383203175716;8816.382853200472;8930.062343453843;6328.810135695937;6409.198850143732;6436.742530298736;6461.741530338733;6484.059811327237;7479.813004674927;8794.42836215644;8887.777805554913;8947.731568052968;9092.499912504876 15:32:22 INFO - PROCESS | 5626 | |3;mootools.html;1364.4542183126748;1370.8492065872756;1471.4261438039166;1661.410199379221;1665.2506372132536;5720.685362305072;5834.533237341013;6431.839204019896;6578.967105164467;6627.502937279699;6451.225852897647;6583.4074933256;6647.567908085983;6691.26396096429;6692.631905245222;1997.7902320256346;2032.4512381656943;2036.0227090996332;2036.4297996560986;2038.9490262743475;1928.5757133430693;1943.2615606069674;1948.5713143108494;1976.2589029114083;1989.3832911797317;2035.6539388304025;2048.09883651193;2052.435580215445;2062.8762274263518;2069.834413246944;2023.6053969475959;2026.6554685703466;2027.432318950696;2028.7464066991479;2034.298167132337;1985.9205631774712;1987.7415935928382;2044.8875311857842;2050.446379477533;2050.7436570428695;6815.352541508549;6861.176658800926;6873.518853680244;6896.689648965808;6913.3777959983845;3827.7129215308964;3918.8432462701458;3923.195744872294;3930.194310166409;3935.330993731073;2635.64418803461;2638.353603367168;2702.189343197033;2728.2088194423595;2740.9588856167175;822.6092606012096;845.4124383553433;861.4308495576068;868.8349213649386;870.7518357268211;8927.107289271085;8931.598078086501;8936.687215947475;8941.552922353856;8950.552472376356;3578.7315951303235;3612.692921101683;3624.3657359961903;3637.690796282293;3641.708663306929;7752.534847909031;7789.415793815373;7799.33705635016;7804.0635123785505;7809.80475488106;4045.696572757055;4061.025353915098;4062.4515690382013;4063.9796801015805;4080.836766529365;3096.040227529473;3174.587303650511;3524.295140971765;3701.9814900925862;3750.587435382106;3145.6697046810214;3160.683931606821;3162.304293055524;3183.7453003759642;3189.266468712209;981.0336818234034;982.5873133284038;988.4810474500945;988.851672249154;991.1971303244395;1080.206048554312;1082.0748260237542;1085.4898197846999;1099.1042300525046;1116.7543140509074;5845.269341332333;5848.766049357978;5874.324452687995;5889.558283128783;6027.367126451747;393.07038853112755;1026.373911913732;1065.6643157405392;1084.8210045342587;1098.4562641492512;4604.217283061887;4665.370175026396;4686.250199968057;4686.95313046872;4702.153612349742;7299.197088320387;8008.27925486709;8023.7994050148045;8069.112397636255;8083.353331733447;7794.454388192886;7811.68753249875;7876.606169691492;7940.960295198487;7946.40401969843;6334.619922804646;6360.650164241011;6455.354464553601;6478.2873883872735;6531.8367040823405;5822.912656310074;5863.882722345615;5888.3228428731245;5901.144334071621;5903.763849445974;7213.098362704662;7237.710491580277;7388.556686598607;7425.740099096506;7500.9249907500225;7507.512011719221;7615;7623.390128789572;7659.502132361378;7719.459637825523;4970.776315065903;5076.36545431821;5439.292891924025;5483.75323110453;5522.5581953442825;5964.194833697569;6094.878102437838;6100.359462256399;6100.908486372619;6118.663473509;5796.565257605612;5895.616784908967;6030.427109424598;6075.483583895419;6163.291221509584;5766.826995190151;5860.736266867916;5861.384554621874;5910.645361278337;5921.615095018982;5677.403872593318;5788.652680839163;5813.157092221689;5824.126381042877;5844.912326315024;5243.973780131075;5249.711265880261;5266.447023062677;5267.104592219409;5270.8155214567305;5552.167174923794;5584.274044374368;5589.748461319169;5590.720463976866;5599.32808063035 15:32:22 INFO - PROCESS | 5626 | |4;prototype.html;275.8910230458969;280.15672824797366;283.4090920430902;285.8085082994395;290.0573137303763;5395.81114660987;5486.862828429291;5528.253685752422;5550.555955523553;5565.137403702428;5480.91778623321;5484.095124304495;5487.451254874511;5496.945030549693;5500.642458240211;4184.979075104636;4202.852900148496;4227.302495088306;4228.260054490467;4231.640310573605;4223.51429585597;4227.196832601811;4228.5982831630945;4229.5981881721345;4233.957660423387;3959.3862951242604;4082.5305089914596;4184.832606695729;4193.993441574015;4195.769232692201;4101.3847922811665;4101.876943691694;4108.055147316104;4108.4864391951005;4108.732932359402;3491.458823882302;3492.458668906298;3492.738044646662;3496.965030349689;3497.9475307870403;5206.635535512516;5293.206019097166;5321.787128514855;5378;5388.811391601314;4745.738984355859;4766.690165139289;4772.260299653524;4781.139394908915;4785.9231672873675;5874.3244526879525;5875.764969401219;5877.206577112078;5880.294364676266;5881.823545293648;3794.772313661189;3855.8072096395067;3867.1105645701646;3872.1674839909556;3872.8257228424786;6072.969635151796;6134.8159555213415;6159.692015399212;6240;6247.468965137969;3958.980205098956;3964.861229856941;3973.9602603974167;3985.8405663773706;3987.461692671452;4007.178528401729;4029.6977726670616;4037.899052523652;4039.394090886332;4043.555208927016;4711.764411779397;4716.103940251342;4722.9763851181215;4731.95268047322;4739.526047395233;5604.41153678866;5662.17898404729;5740.196372507852;5765.423457654285;5771.769129234867;1393.414765798347;1415.2216281045385;1416.9291535423188;1417.461364681435;1423.501774378959;908.9590968406437;908.9909100908907;924.075924075924;925.0564424287189;927.4667066436691;4953.25701144824;4966.751662416865;4967.726775027336;5004.974975125174;5047.394312682428;5955.970220148872;5979.820605381846;5985.16207730918;5986.742784015319;5988.371221021817;5009.799608015712;5014.398272207359;5020.171671674206;5022;5028.622853286018;3205.6634053424523;3220.436423625856;3251.089694885436;3270.6238782540313;3271.165852707544;5703.458171473703;5706.25818643582;5707.1724599933605;5708.4862362387585;5723.914141287884;6192.164057852222;6238.594491358047;6245.064030150668;6245.375462453809;6247.781327653511;5562.054450743383;5684.431556844283;5720.256366672306;5723.914141287884;5729;5962.970185149046;6068.4841788448475;6077.4226448487325;6077.787277445268;6089.786857459968;5935.970320148372;5938.257717785277;5943.613665111754;5949.929012777741;5953.493953014043;5648.830535083954;5668.886622267449;5692.203091567101;5696.430356964271;5703.657780533182;3812.8474861005247;3927.7054220934115;3941.6452519273403;3954.9406758898062;3960.405939109157;5997.13041608973;6082.118092876596;6094.75620975156;6104.32852386246;6170.629762214281;5896.292444906467;5900.940990590039;5916.852078698067;5930.703464826827;5934.554908381802;5849.883002340014;5886.3525012247765;5895.882082358415;5908.409159084229;5920.37836027211;5584.916226256691;5750.367459579359;5767.826965191051;5770.682612456355;5771.624844385102;5924.763009479572;5934.940650593611;5945.197398351167;5954.612950158225;5970.283565972111;5770.538356931519;5780.797672081457;5782.826515204551;5789.768409263583;5796.884062318814 15:32:22 INFO - PROCESS | 5626 | |5;yui.html;630.3664816859057;671.0672165689696;728.0644371982004;738.9187189409164;767.4244316762432;10844.837327440095;10849.457527123643;10880.891191088087;10964.725881852948;10992.450377481124;12636.557720479785;12895.226286422821;12976.675583110427;12992.610221693341;13036.087473876809;601.0983524712931;604.8850718363519;747.4095464582973;759.5784339691469;763.5952944939191;742.476554029408;747.178104085507;753.7135888362442;754.0273047768372;754.6000619671555;780.3172224303735;782.8590853646341;786.2216405758315;788.4677842456348;791.8495485857669;771.9575423351713;776.7164984780571;776.7708525984848;778.704092444873;781.5076501803884;577.9537636989031;580.9564282678816;584.8654809393821;585.3356440440089;587.0460501684762;11695.239809412446;11727.237729547638;11746.236494627821;11774.411279435993;11776.234544754649;10540.578376864993;10726.678199654023;10890.67327980154;10890.836637450444;10917.945410272978;9689.854652180224;9743.65897193602;9763.951180244125;9783.706488805346;9860.704178874645;3246.2209069823307;3261.72275356595;3268.2809781847955;3293.571835661349;3305.5537502437105;37183.25633487342;37684.81157594222;37740.43389349162;37775;38420.42369364462;9147.085291470932;9250.074992500697;9326.95336523313;9379.765505862271;9421.952890235505;15072.924635376972;15076.321565529577;15087.396504139711;15096.924515377354;15106.320215590325;6046.3651316612;6145.477634401037;6220.377962203834;6284.4344009039405;6286;3662.6703596676425;3712.276106159327;3728.422094575345;3777.7166712496673;3819.7899115548357;2595.532804095243;2609.0346571768187;2624.842509449439;2630.07947218472;2651.4034342272835;482.80929033031754;485.1848893858281;489.33694843487274;492.3918960084293;492.9482404347492;511.6955411530134;547.1929102831684;560.949514543693;561.4161272276787;564.266453610305;7322.890156647654;7480.812979675443;7508.887366689504;7593.278638529331;7694.153643099255;437.0952129092811;464.8837790552362;477.31743606642834;514.565192412411;575.3929604267454;3400.59192896854;3476.582810062758;3502.9474557881654;3571.4107172316794;3579.1767893384144;46866.5313346869;47144.5285547147;47212.7639361801;47254;47286.29070563944;39258.41112383317;39839.20321593552;39866.20267594632;39959.20489541274;41395.793021034704;38141.23717525634;38169.80915095407;38181;39094.21811563753;39143.217135657695;7416.406687465098;7626.9618651906385;8117.512949223065;8121.634526446443;8343.833123337621;28333.008344707836;28497.28756781097;28919;29044.419111617226;30205.09384718374;36070.63929360673;36976.44535332026;37158.07104822401;37253.62746372502;37365.065873352294;9621.90378096238;9794;9868.950655246677;9889.703308900744;10162.339447935861;11167.609133680282;11189.440527973406;11374.545018199511;11547.826782598437;12175.75648487043;10146.340487868265;10148.575301910325;10328;10569.048785609331;10677.09244714208;10014.298999069995;10184.338018028804;10260.230482713976;10324.174066074846;10721.571137154426;9714.3199976001;9911.10800028001;9925.305228633926;9935.850962235716;9960.800783984425;8276.337892968428;8372.41393102477;8459.661613535389;8463.957680211559;8502.362322825937;8420.326373889951;8514.31885449175;8543.487390756574;8584.442011269248;8759.824803504021 15:32:22 INFO - PROCESS | 5626 | __end_tp_report 15:32:22 INFO - PROCESS | 5626 | __start_cc_report 15:32:22 INFO - PROCESS | 5626 | _x_x_mozilla_cycle_collect,314 15:32:22 INFO - PROCESS | 5626 | __end_cc_report 15:32:22 INFO - PROCESS | 5626 | __startTimestamp1452987142228__endTimestamp 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - PROCESS | 5626 | ------- Summary: start ------- 15:32:22 INFO - PROCESS | 5626 | Number of tests: 6 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - PROCESS | 5626 | [#0] dojo.html Cycles:165 Average:4458.95 Median:4552.48 stddev:437.87 (9.6%) stddev-sans-first:415.08 15:32:22 INFO - PROCESS | 5626 | Values: 2631.4 2675.4 2700.1 2701.7 2719.2 4373.9 4483.9 4484.5 4527.5 4547.9 4462.0 4493.7 4502.2 4560.7 4562.2 4169.5 4219.4 4225.4 4293.6 4300.8 4032.3 4213.6 4250.2 4253.6 4272.6 4112.5 4128.4 4180.6 4184.1 4239.4 4200.2 4206.5 4210.6 4214.0 4232.9 4088.5 4159.9 4172.5 4186.4 4207.5 4387.1 4469.2 4495.6 4519.8 4522.2 4793.1 4802.1 4814.8 4820.8 4861.5 4707.8 4785.2 4790.5 4852.2 4865.3 4466.4 4472.6 4501.1 4521.4 4542.3 4915.3 4922.2 4924.1 4931.9 4972.1 4638.5 4704.8 4706.8 4737.6 4812.8 4816.3 4821.2 4831.3 4831.6 4865.0 4779.8 4793.4 4796.2 4797.0 4848.4 4650.0 4745.6 4749.8 4782.6 4825.1 4007.8 4013.8 4022.1 4031.8 4051.9 3539.5 3578.6 3584.7 3606.0 3616.6 4122.4 4146.8 4205.9 4208.1 4241.7 4780.9 4834.8 4844.7 4845.4 4876.0 4049.5 4128.0 4187.5 4194.8 4198.2 4236.0 4242.1 4249.2 4326.5 4344.3 4500.6 4518.1 4519.5 4535.8 4548.1 4722.1 4765.4 4774.1 4775.6 4810.5 4530.2 4550.3 4568.5 4580.7 4591.7 4779.2 4785.0 4786.8 4792.6 4829.4 4681.6 4755.2 4801.5 4830.3 4836.0 4620.5 4673.6 4680.9 4693.1 4728.1 4680.3 4704.9 4708.2 4725.0 4749.1 4481.6 4547.4 4552.5 4631.4 4632.0 4720.7 4727.9 4733.2 4739.9 4748.6 4628.7 4629.3 4634.1 4634.2 4665.5 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - PROCESS | 5626 | [#1] ext.html Cycles:180 Average:39553.53 Median:32907.70 stddev:65866.56 (200.2%) stddev-sans-first:65986.00 15:32:22 INFO - PROCESS | 5626 | Values: 479.2 482.1 489.5 499.3 503.3 24889.1 32398.7 32695.5 32719.7 32759.9 35726.3 36493.5 36580.3 36621.8 36648.0 7590.6 7758.0 7866.6 7878.1 7881.6 7591.8 7642.8 7696.3 7745.3 7794.5 7725.5 7864.7 7871.0 7874.1 7885.4 7757.4 7800.2 7829.8 7852.3 7861.1 7540.9 7649.8 7700.1 7722.8 7728.1 34442.1 34549.3 34758.3 34765.8 34859.7 2776.7 2789.0 3014.2 3111.5 3520.6 26990.7 27076.6 27302.7 27310.3 27529.3 3253.5 3270.5 3315.8 3356.3 3416.9 214616.0 214770.0 215930.0 217454.0 217502.0 44472.0 45488.0 50083.2 51687.2 52439.0 45581.0 45657.3 45689.8 45726.1 45880.3 12532.6 12624.9 12639.9 12730.2 12753.7 9501.6 9524.7 9535.9 9580.9 9618.1 17153.0 17619.1 17706.5 17796.4 17801.0 7022.7 7185.2 7208.1 7209.6 7239.6 788.0 842.0 895.9 958.3 983.5 25566.6 25735.9 26107.5 26144.9 26303.2 897.5 912.9 935.9 938.8 976.1 13429.5 13493.4 13885.4 13985.4 14254.1 273577.0 277389.0 277871.0 279322.0 279423.0 44260.3 44417.3 44450.0 44461.6 44647.0 1144.7 1150.5 1153.3 1159.9 1295.2 25410.0 25577.5 25619.9 25789.7 25927.6 38275.6 38661.2 38738.4 38783.6 38835.8 257280.0 258677.0 259467.0 260003.0 261903.0 26609.9 27643.2 28308.2 28322.0 28605.3 33055.5 33066.8 34672.3 35276.6 35536.8 29855.3 30143.7 30591.4 30713.5 30764.2 28104.7 28264.2 28542.9 28584.4 29318.6 28644.3 28837.0 28899.9 28907.9 29054.0 26871.5 29075.7 29779.9 31133.5 32414.0 21781.5 22880.8 22968.8 23040.4 23196.3 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - PROCESS | 5626 | [#2] jquery.html Cycles:180 Average:22309.79 Median:463876.00 stddev:65300.83 (14.1%) stddev-sans-first:65463.16 15:32:22 INFO - PROCESS | 5626 | Values: 328.5 336.4 337.5 341.8 343.1 14029.6 14627.3 14899.3 14932.5 15713.4 8758.4 9007.1 10445.5 13856.4 13890.7 4212.1 4212.1 4396.3 4396.8 4413.3 4749.5 4753.9 4760.5 4765.7 4768.7 3307.3 3432.4 4599.8 4977.6 5987.3 6160.8 6312.1 6381.4 6386.9 6387.6 6113.1 6124.6 6131.3 6133.6 6137.9 17825.6 19631.6 20632.0 20721.5 20761.3 1867.2 1908.1 1935.5 2035.9 2118.9 13025.3 13083.9 13340.5 13603.5 13633.1 1882.1 1901.8 1906.6 1940.5 1969.0 52331.7 52683.3 53766.9 54176.7 54656.7 14343.8 14616.1 14637.6 14654.3 14684.9 21708.1 21779.6 21947.2 22031.0 22037.1 7119.1 7333.4 7346.1 7352.1 7442.1 5813.8 5842.7 5899.5 5917.3 5926.7 7157.6 7163.3 7279.1 7331.8 7408.6 2924.0 2935.2 2953.7 2956.9 2982.4 319.5 323.9 324.5 328.8 351.7 8569.7 8745.2 8857.6 8999.0 9107.7 342.4 350.6 357.2 364.7 365.9 4863.4 4939.0 5079.6 8477.5 8819.9 276728.0 283674.0 457780.0 463646.0 464106.0 40103.0 54481.2 60308.7 61668.0 64342.7 1014.2 1025.8 1032.3 1037.2 1047.2 13468.1 13605.8 13833.8 13908.6 13953.6 28415.6 29421.4 29759.4 30276.2 30695.2 37783.6 39024.0 39114.8 39273.8 39930.8 5847.7 5881.5 5889.4 5901.4 5915.7 6530.6 8841.6 8989.6 9152.1 9164.3 7965.4 8162.2 8351.5 8489.7 8590.1 8552.1 8576.9 8783.4 8871.2 8987.4 8647.0 8730.3 8811.4 8816.4 8930.1 6328.8 6409.2 6436.7 6461.7 6484.1 7479.8 8794.4 8887.8 8947.7 9092.5 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - PROCESS | 5626 | [#3] mootools.html Cycles:180 Average:4619.43 Median:5699.04 stddev:2363.09 (41.5%) stddev-sans-first:2357.06 15:32:22 INFO - PROCESS | 5626 | Values: 1364.5 1370.8 1471.4 1661.4 1665.3 5720.7 5834.5 6431.8 6579.0 6627.5 6451.2 6583.4 6647.6 6691.3 6692.6 1997.8 2032.5 2036.0 2036.4 2038.9 1928.6 1943.3 1948.6 1976.3 1989.4 2035.7 2048.1 2052.4 2062.9 2069.8 2023.6 2026.7 2027.4 2028.7 2034.3 1985.9 1987.7 2044.9 2050.4 2050.7 6815.4 6861.2 6873.5 6896.7 6913.4 3827.7 3918.8 3923.2 3930.2 3935.3 2635.6 2638.4 2702.2 2728.2 2741.0 822.6 845.4 861.4 868.8 870.8 8927.1 8931.6 8936.7 8941.6 8950.6 3578.7 3612.7 3624.4 3637.7 3641.7 7752.5 7789.4 7799.3 7804.1 7809.8 4045.7 4061.0 4062.5 4064.0 4080.8 3096.0 3174.6 3524.3 3702.0 3750.6 3145.7 3160.7 3162.3 3183.7 3189.3 981.0 982.6 988.5 988.9 991.2 1080.2 1082.1 1085.5 1099.1 1116.8 5845.3 5848.8 5874.3 5889.6 6027.4 393.1 1026.4 1065.7 1084.8 1098.5 4604.2 4665.4 4686.3 4687.0 4702.2 7299.2 8008.3 8023.8 8069.1 8083.4 7794.5 7811.7 7876.6 7941.0 7946.4 6334.6 6360.7 6455.4 6478.3 6531.8 5822.9 5863.9 5888.3 5901.1 5903.8 7213.1 7237.7 7388.6 7425.7 7500.9 7507.5 7615.0 7623.4 7659.5 7719.5 4970.8 5076.4 5439.3 5483.8 5522.6 5964.2 6094.9 6100.4 6100.9 6118.7 5796.6 5895.6 6030.4 6075.5 6163.3 5766.8 5860.7 5861.4 5910.6 5921.6 5677.4 5788.7 5813.2 5824.1 5844.9 5244.0 5249.7 5266.4 5267.1 5270.8 5552.2 5584.3 5589.7 5590.7 5599.3 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - PROCESS | 5626 | [#4] prototype.html Cycles:180 Average:4778.38 Median:5498.79 stddev:1464.78 (26.6%) stddev-sans-first:1429.37 15:32:22 INFO - PROCESS | 5626 | Values: 275.9 280.2 283.4 285.8 290.1 5395.8 5486.9 5528.3 5550.6 5565.1 5480.9 5484.1 5487.5 5496.9 5500.6 4185.0 4202.9 4227.3 4228.3 4231.6 4223.5 4227.2 4228.6 4229.6 4234.0 3959.4 4082.5 4184.8 4194.0 4195.8 4101.4 4101.9 4108.1 4108.5 4108.7 3491.5 3492.5 3492.7 3497.0 3497.9 5206.6 5293.2 5321.8 5378.0 5388.8 4745.7 4766.7 4772.3 4781.1 4785.9 5874.3 5875.8 5877.2 5880.3 5881.8 3794.8 3855.8 3867.1 3872.2 3872.8 6073.0 6134.8 6159.7 6240.0 6247.5 3959.0 3964.9 3974.0 3985.8 3987.5 4007.2 4029.7 4037.9 4039.4 4043.6 4711.8 4716.1 4723.0 4732.0 4739.5 5604.4 5662.2 5740.2 5765.4 5771.8 1393.4 1415.2 1416.9 1417.5 1423.5 909.0 909.0 924.1 925.1 927.5 4953.3 4966.8 4967.7 5005.0 5047.4 5956.0 5979.8 5985.2 5986.7 5988.4 5009.8 5014.4 5020.2 5022.0 5028.6 3205.7 3220.4 3251.1 3270.6 3271.2 5703.5 5706.3 5707.2 5708.5 5723.9 6192.2 6238.6 6245.1 6245.4 6247.8 5562.1 5684.4 5720.3 5723.9 5729.0 5963.0 6068.5 6077.4 6077.8 6089.8 5936.0 5938.3 5943.6 5949.9 5953.5 5648.8 5668.9 5692.2 5696.4 5703.7 3812.8 3927.7 3941.6 3954.9 3960.4 5997.1 6082.1 6094.8 6104.3 6170.6 5896.3 5900.9 5916.9 5930.7 5934.6 5849.9 5886.4 5895.9 5908.4 5920.4 5584.9 5750.4 5767.8 5770.7 5771.6 5924.8 5934.9 5945.2 5954.6 5970.3 5770.5 5780.8 5782.8 5789.8 5796.9 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - PROCESS | 5626 | [#5] yui.html Cycles:180 Average:11653.29 Median:47233.38 stddev:12838.80 (27.2%) stddev-sans-first:12848.13 15:32:22 INFO - PROCESS | 5626 | Values: 630.4 671.1 728.1 738.9 767.4 10844.8 10849.5 10880.9 10964.7 10992.5 12636.6 12895.2 12976.7 12992.6 13036.1 601.1 604.9 747.4 759.6 763.6 742.5 747.2 753.7 754.0 754.6 780.3 782.9 786.2 788.5 791.8 772.0 776.7 776.8 778.7 781.5 578.0 581.0 584.9 585.3 587.0 11695.2 11727.2 11746.2 11774.4 11776.2 10540.6 10726.7 10890.7 10890.8 10917.9 9689.9 9743.7 9764.0 9783.7 9860.7 3246.2 3261.7 3268.3 3293.6 3305.6 37183.3 37684.8 37740.4 37775.0 38420.4 9147.1 9250.1 9327.0 9379.8 9422.0 15072.9 15076.3 15087.4 15096.9 15106.3 6046.4 6145.5 6220.4 6284.4 6286.0 3662.7 3712.3 3728.4 3777.7 3819.8 2595.5 2609.0 2624.8 2630.1 2651.4 482.8 485.2 489.3 492.4 492.9 511.7 547.2 560.9 561.4 564.3 7322.9 7480.8 7508.9 7593.3 7694.2 437.1 464.9 477.3 514.6 575.4 3400.6 3476.6 3502.9 3571.4 3579.2 46866.5 47144.5 47212.8 47254.0 47286.3 39258.4 39839.2 39866.2 39959.2 41395.8 38141.2 38169.8 38181.0 39094.2 39143.2 7416.4 7627.0 8117.5 8121.6 8343.8 28333.0 28497.3 28919.0 29044.4 30205.1 36070.6 36976.4 37158.1 37253.6 37365.1 9621.9 9794.0 9869.0 9889.7 10162.3 11167.6 11189.4 11374.5 11547.8 12175.8 10146.3 10148.6 10328.0 10569.0 10677.1 10014.3 10184.3 10260.2 10324.2 10721.6 9714.3 9911.1 9925.3 9935.9 9960.8 8276.3 8372.4 8459.7 8464.0 8502.4 8420.3 8514.3 8543.5 8584.4 8759.8 15:32:22 INFO - PROCESS | 5626 | -------- Summary: end -------- 15:32:22 INFO - PROCESS | 5626 | 15:32:22 INFO - TEST-INFO | 5626: exit 0 15:32:22 INFO - TEST-OK | dromaeo_css | took 1114300ms 15:32:22 INFO - TEST-START | kraken 15:32:22 INFO - operating with platform_type : linux_ 15:32:22 INFO - Initialising browser for kraken test... 15:32:22 INFO - TEST-INFO | started process 5868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvcIuj2/profile http://localhost:58493/getInfo.html) 15:32:26 INFO - PROCESS | 5868 | 15:32:26 INFO - PROCESS | 5868 | (process:5939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:32:27 INFO - PROCESS | 5868 | __metrics Screen width/height:1600/1200 15:32:27 INFO - PROCESS | 5868 | colorDepth:24 15:32:27 INFO - PROCESS | 5868 | Browser inner width/height: 1024/697 15:32:27 INFO - PROCESS | 5868 | __metrics 15:32:27 INFO - PROCESS | 5868 | 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:32:28 INFO - TEST-INFO | 5868: exit 0 15:32:28 INFO - Browser initialized. 15:32:28 INFO - Running cycle 1/1 for kraken test... 15:32:28 INFO - TEST-INFO | started process 5988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvcIuj2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:30 INFO - PROCESS | 5988 | 15:32:30 INFO - PROCESS | 5988 | (process:6044): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:32:40 INFO - PROCESS | 5988 | RSS: Main: 150638592 15:32:40 INFO - PROCESS | 5988 | 15:32:43 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58493/tests/kraken/driver.html?testName=audio-beat-detection) 15:32:44 INFO - PROCESS | 5988 | RSS: Main: 149598208 15:32:44 INFO - PROCESS | 5988 | 15:32:46 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58493/tests/kraken/driver.html?testName=audio-dft) 15:32:47 INFO - PROCESS | 5988 | RSS: Main: 153268224 15:32:47 INFO - PROCESS | 5988 | 15:32:50 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58493/tests/kraken/driver.html?testName=audio-fft) 15:32:51 INFO - PROCESS | 5988 | RSS: Main: 147644416 15:32:51 INFO - PROCESS | 5988 | 15:32:53 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58493/tests/kraken/driver.html?testName=audio-oscillator) 15:32:53 INFO - PROCESS | 5988 | RSS: Main: 147234816 15:32:53 INFO - PROCESS | 5988 | 15:32:55 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58493/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:32:56 INFO - PROCESS | 5988 | RSS: Main: 148738048 15:32:56 INFO - PROCESS | 5988 | 15:32:59 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58493/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:00 INFO - PROCESS | 5988 | RSS: Main: 147546112 15:33:00 INFO - PROCESS | 5988 | 15:33:03 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58493/tests/kraken/driver.html?testName=imaging-desaturate) 15:33:04 INFO - PROCESS | 5988 | RSS: Main: 147443712 15:33:04 INFO - PROCESS | 5988 | 15:33:07 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58493/tests/kraken/driver.html?testName=json-parse-financial) 15:33:07 INFO - PROCESS | 5988 | RSS: Main: 148520960 15:33:07 INFO - PROCESS | 5988 | 15:33:09 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58493/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:33:10 INFO - PROCESS | 5988 | RSS: Main: 148357120 15:33:10 INFO - PROCESS | 5988 | 15:33:12 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:33:12 INFO - PROCESS | 5988 | RSS: Main: 148754432 15:33:12 INFO - PROCESS | 5988 | 15:33:14 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:33:15 INFO - PROCESS | 5988 | RSS: Main: 148959232 15:33:15 INFO - PROCESS | 5988 | 15:33:18 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:33:18 INFO - PROCESS | 5988 | RSS: Main: 149110784 15:33:18 INFO - PROCESS | 5988 | 15:33:21 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:33:21 INFO - PROCESS | 5988 | RSS: Main: 150372352 15:33:21 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58493/tests/kraken/driver.html?testName=ai-astar) 15:33:23 INFO - PROCESS | 5988 | RSS: Main: 149815296 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | __start_tp_report 15:33:23 INFO - PROCESS | 5988 | _x_x_mozilla_page_load 15:33:23 INFO - PROCESS | 5988 | _x_x_mozilla_page_load_details 15:33:23 INFO - PROCESS | 5988 | |i|pagename|runs| 15:33:23 INFO - PROCESS | 5988 | |0;ai-astar;115;109;115;115;116;125;114;115;114;115 15:33:23 INFO - PROCESS | 5988 | |1;audio-beat-detection;157;141;165;168;144;154;155;140;180;134 15:33:23 INFO - PROCESS | 5988 | |2;audio-dft;161;161;163;165;162;172;162;160;165;161 15:33:23 INFO - PROCESS | 5988 | |3;audio-fft;71;73;72;74;140;74;73;72;72;151 15:33:23 INFO - PROCESS | 5988 | |4;audio-oscillator;97;98;143;97;98;98;137;98;98;135 15:33:23 INFO - PROCESS | 5988 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;109;111;110 15:33:23 INFO - PROCESS | 5988 | |6;imaging-darkroom;149;148;147;149;148;148;147;147;148;147 15:33:23 INFO - PROCESS | 5988 | |7;imaging-desaturate;96;98;96;96;96;97;96;97;97;96 15:33:23 INFO - PROCESS | 5988 | |8;json-parse-financial;69;71;70;69;68;70;70;77;67;70 15:33:23 INFO - PROCESS | 5988 | |9;json-stringify-tinderbox;69;68;68;67;68;69;69;68;68;68 15:33:23 INFO - PROCESS | 5988 | |10;stanford-crypto-aes;84;85;84;86;86;86;88;85;91;85 15:33:23 INFO - PROCESS | 5988 | |11;stanford-crypto-ccm;118;120;122;129;120;135;122;123;139;126 15:33:23 INFO - PROCESS | 5988 | |12;stanford-crypto-pbkdf2;139;147;147;137;158;134;147;152;142;138 15:33:23 INFO - PROCESS | 5988 | |13;stanford-crypto-sha256-iterative;74;70;70;71;71;69;70;78;68;70 15:33:23 INFO - PROCESS | 5988 | __end_tp_report 15:33:23 INFO - PROCESS | 5988 | __start_cc_report 15:33:23 INFO - PROCESS | 5988 | _x_x_mozilla_cycle_collect,826 15:33:23 INFO - PROCESS | 5988 | __end_cc_report 15:33:23 INFO - PROCESS | 5988 | __startTimestamp1452987203931__endTimestamp 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | ------- Summary: start ------- 15:33:23 INFO - PROCESS | 5988 | Number of tests: 14 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:3.92 (3.4%) stddev-sans-first:4.15 15:33:23 INFO - PROCESS | 5988 | Values: 115.0 109.0 115.0 115.0 116.0 125.0 114.0 115.0 114.0 115.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:156.00 stddev:14.41 (9.2%) stddev-sans-first:15.23 15:33:23 INFO - PROCESS | 5988 | Values: 157.0 141.0 165.0 168.0 144.0 154.0 155.0 140.0 180.0 134.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:3.52 (2.2%) stddev-sans-first:3.64 15:33:23 INFO - PROCESS | 5988 | Values: 161.0 161.0 163.0 165.0 162.0 172.0 162.0 160.0 165.0 161.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#3] audio-fft Cycles:10 Average:87.20 Median:72.50 stddev:30.85 (42.6%) stddev-sans-first:32.16 15:33:23 INFO - PROCESS | 5988 | Values: 71.0 73.0 72.0 74.0 140.0 74.0 73.0 72.0 72.0 151.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:98.00 stddev:19.72 (20.1%) stddev-sans-first:20.36 15:33:23 INFO - PROCESS | 5988 | Values: 97.0 98.0 143.0 97.0 98.0 98.0 137.0 98.0 98.0 135.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:33:23 INFO - PROCESS | 5988 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 111.0 110.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 15:33:23 INFO - PROCESS | 5988 | Values: 149.0 148.0 147.0 149.0 148.0 148.0 147.0 147.0 148.0 147.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 15:33:23 INFO - PROCESS | 5988 | Values: 96.0 98.0 96.0 96.0 96.0 97.0 96.0 97.0 97.0 96.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#8] json-parse-financial Cycles:10 Average:70.10 Median:70.00 stddev:2.69 (3.8%) stddev-sans-first:2.82 15:33:23 INFO - PROCESS | 5988 | Values: 69.0 71.0 70.0 69.0 68.0 70.0 70.0 77.0 67.0 70.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 15:33:23 INFO - PROCESS | 5988 | Values: 69.0 68.0 68.0 67.0 68.0 69.0 69.0 68.0 68.0 68.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:2.11 (2.5%) stddev-sans-first:2.11 15:33:23 INFO - PROCESS | 5988 | Values: 84.0 85.0 84.0 86.0 86.0 86.0 88.0 85.0 91.0 85.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:124.50 stddev:6.93 (5.6%) stddev-sans-first:6.82 15:33:23 INFO - PROCESS | 5988 | Values: 118.0 120.0 122.0 129.0 120.0 135.0 122.0 123.0 139.0 126.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:147.00 stddev:7.46 (5.1%) stddev-sans-first:7.68 15:33:23 INFO - PROCESS | 5988 | Values: 139.0 147.0 147.0 137.0 158.0 134.0 147.0 152.0 142.0 138.0 15:33:23 INFO - PROCESS | 5988 | 15:33:23 INFO - PROCESS | 5988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:2.88 (4.1%) stddev-sans-first:2.86 15:33:23 INFO - PROCESS | 5988 | Values: 74.0 70.0 70.0 71.0 71.0 69.0 70.0 78.0 68.0 70.0 15:33:23 INFO - PROCESS | 5988 | -------- Summary: end -------- 15:33:23 INFO - PROCESS | 5988 | 15:33:24 INFO - TEST-INFO | 5988: exit 0 15:33:24 INFO - TEST-OK | kraken | took 61942ms 15:33:24 INFO - TEST-START | v8_7 15:33:24 INFO - operating with platform_type : linux_ 15:33:24 INFO - Initialising browser for v8_7 test... 15:33:24 INFO - TEST-INFO | started process 6272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphBj83p/profile http://localhost:58493/getInfo.html) 15:33:28 INFO - PROCESS | 6272 | 15:33:28 INFO - PROCESS | 6272 | (process:6342): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:33:29 INFO - PROCESS | 6272 | __metrics Screen width/height:1600/1200 15:33:29 INFO - PROCESS | 6272 | colorDepth:24 15:33:29 INFO - PROCESS | 6272 | Browser inner width/height: 1024/697 15:33:29 INFO - PROCESS | 6272 | __metrics 15:33:29 INFO - PROCESS | 6272 | 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:33:30 INFO - TEST-INFO | 6272: exit 0 15:33:30 INFO - Browser initialized. 15:33:30 INFO - Running cycle 1/1 for v8_7 test... 15:33:30 INFO - TEST-INFO | started process 6391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphBj83p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:32 INFO - PROCESS | 6391 | 15:33:32 INFO - PROCESS | 6391 | (process:6448): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:33:42 INFO - PROCESS | 6391 | RSS: Main: 150380544 15:33:42 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | Cycle 1(1): loaded http://localhost:58493/tests/v8_7/run.html (next: http://localhost:58493/tests/v8_7/run.html) 15:34:05 INFO - PROCESS | 6391 | RSS: Main: 144760832 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | __start_tp_report 15:34:05 INFO - PROCESS | 6391 | _x_x_mozilla_page_load 15:34:05 INFO - PROCESS | 6391 | _x_x_mozilla_page_load_details 15:34:05 INFO - PROCESS | 6391 | |i|pagename|runs| 15:34:05 INFO - PROCESS | 6391 | |0;Richards;166.08536787908986 15:34:05 INFO - PROCESS | 6391 | |1;DeltaBlue;186.35855385762207 15:34:05 INFO - PROCESS | 6391 | |2;Encrypt;278.473962684489 15:34:05 INFO - PROCESS | 6391 | |3;Decrypt;5251.308900523561 15:34:05 INFO - PROCESS | 6391 | |4;RayTrace;1082.162162162162 15:34:05 INFO - PROCESS | 6391 | |5;Earley;714.2857142857143 15:34:05 INFO - PROCESS | 6391 | |6;Boyer;12432.098765432098 15:34:05 INFO - PROCESS | 6391 | |7;RegExp;43937.5 15:34:05 INFO - PROCESS | 6391 | |8;Splay;594.5303210463734 15:34:05 INFO - PROCESS | 6391 | |9;NavierStokes;4822.115384615385 15:34:05 INFO - PROCESS | 6391 | __end_tp_report 15:34:05 INFO - PROCESS | 6391 | __startTimestamp1452987245557__endTimestamp 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | ------- Summary: start ------- 15:34:05 INFO - PROCESS | 6391 | Number of tests: 10 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 166.1 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#1] DeltaBlue Cycles:1 Average:186.36 Median:186.36 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 186.4 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 278.5 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 5251.3 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#4] RayTrace Cycles:1 Average:1082.16 Median:1082.16 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 1082.2 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 714.3 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 12432.1 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#7] RegExp Cycles:1 Average:43937.50 Median:43937.50 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 43937.5 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#8] Splay Cycles:1 Average:594.53 Median:594.53 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 594.5 15:34:05 INFO - PROCESS | 6391 | 15:34:05 INFO - PROCESS | 6391 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 15:34:05 INFO - PROCESS | 6391 | Values: 4822.1 15:34:05 INFO - PROCESS | 6391 | -------- Summary: end -------- 15:34:05 INFO - PROCESS | 6391 | 15:34:06 INFO - TEST-INFO | 6391: exit 0 15:34:06 INFO - TEST-OK | v8_7 | took 41637ms 15:34:06 INFO - SUITE-END | took 1217s 15:34:07 INFO - Completed test suite (00:20:18) 15:34:07 INFO - Working with test: dromaeo_css 15:34:07 INFO - Generating results file: dromaeo_css 15:34:07 INFO - Working with test: kraken 15:34:07 INFO - Generating results file: kraken 15:34:07 INFO - javascript benchmark 15:34:07 INFO - Working with test: v8_7 15:34:07 INFO - Generating results file: v8_7 15:34:07 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:34:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 15:34:07 INFO - process_Request line: dromaeo_css 6005.44 graph.html#tests=[[72,132,43]] 15:34:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:34:07 INFO - process_Request line: kraken 1548.50 graph.html#tests=[[232,132,43]] 15:34:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:34:07 INFO - process_Request line: v8_7 20246.82 graph.html#tests=[[230,132,43]] 15:34:07 INFO - RETURN: dromaeo_css: 6005.44 15:34:07 INFO - RETURN: kraken: 1548.50 15:34:07 INFO - RETURN: v8_7: 20246.82 15:34:07 INFO - javascript benchmark 15:34:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2631.4342416380473, 2675.3712877473804, 2700.1494529223305, 2701.7163197864224, 2719.225020869052, 4373.868783936479, 4483.86548403548, 4484.506704262532, 4527.501974782771, 4547.909041819165, 4461.955380446195, 4493.685442019052, 4502.23462011458, 4560.657950653706, 4562.156001139791, 4169.541350451448, 4219.430376899126, 4225.366195070733, 4293.613574778269, 4300.849470268541, 4032.2540330039037, 4213.5786421357925, 4250.171216612762, 4253.553376895427, 4272.615464608185, 4112.465379500646, 4128.401381799652, 4180.602842729936, 4184.142250838601, 4239.385289133058, 4200.243956087903, 4206.495220573551, 4210.578942105795, 4213.9578604213875, 4232.894177645553, 4088.468499095128, 4159.9376009359885, 4172.457580514514, 4186.35111557709, 4207.51613564441, 4387.100644367897, 4469.150861336336, 4495.595396414338, 4519.84180553679, 4522.23122069249, 4793.089313030548, 4802.087603355351, 4814.807407703687, 4820.8071677132875, 4861.465238823726, 4707.7881495332795, 4785.162596545625, 4790.5448982346625, 4852.1508735971065, 4865.2945322928335, 4466.3747075409465, 4472.642188624902, 4501.122281155143, 4521.36700861873, 4542.295944128632, 4915.311856340115, 4922.163232250526, 4924.113659541317, 4931.852044438672, 4972.0801651694555, 4638.489766125724, 4704.788284527204, 4706.811727530929, 4737.573618374363, 4812.783424745895, 4816.349792778, 4821.2045012572535, 4831.347768051268, 4831.589314908272, 4864.975675121673, 4779.761011949388, 4793.376861008047, 4796.232602783538, 4796.976015119972, 4848.369711937426, 4649.976750116295, 4745.620350371962, 4749.786259618326, 4782.593479554277, 4825.083234185494, 4007.8396864125693, 4013.779242141652, 4022.1151346703678, 4031.7984100794843, 4051.9392209116886, 3539.50446937429, 3578.5526809148855, 3584.713222942158, 3606.026372879308, 3616.6021737608844, 4122.40225167349, 4146.79266036703, 4205.927488490415, 4208.116295577902, 4241.660667146621, 4780.904381912343, 4834.7824347904425, 4844.660873738875, 4845.416202451064, 4876.024795041006, 4049.493813273341, 4127.9587204128175, 4187.5184353799705, 4194.832206711759, 4198.223328684203, 4236.046889449849, 4242.109157076987, 4249.150169966019, 4326.502452217972, 4344.348347747863, 4500.572445617661, 4518.051209246029, 4519.4576650801455, 4535.8185672574045, 4548.13585418776, 4722.055588882168, 4765.404324459442, 4774.140654682191, 4775.594074503706, 4810.542998415145, 4530.207213737649, 4550.317452382169, 4568.474625418119, 4580.702254353457, 4591.724496530219, 4779.235322348408, 4785.0, 4786.8085276588545, 4792.640551958547, 4829.444613869309, 4681.648876334357, 4755.1916174251155, 4801.4958429364415, 4830.347903033045, 4836.0, 4620.514845941262, 4673.556012178838, 4680.923387620935, 4693.0613877224005, 4728.0543891221205, 4680.297955306732, 4704.858854234379, 4708.246680531099, 4725.031368569366, 4749.121412538691, 4481.596656300949, 4547.431571053618, 4552.476465206543, 4631.397918270603, 4631.976840115778, 4720.669553131385, 4727.881802954954, 4733.242681170997, 4739.857804265877, 4748.596369308648, 4628.652851036253, 4629.305604159403, 4634.119517291704, 4634.165850147006, 4665.5101214372], "unit": "score", "name": "dojo.html", "value": 4433.499039618243}, {"lowerIsBetter": false, "replicates": [479.161467431994, 482.1417876180398, 489.52516059422345, 499.33338992445096, 503.30795156659593, 24889.12888048919, 32398.67601323986, 32695.50956735651, 32719.67280327196, 32759.88781065798, 35726.28547429056, 36493.452598210984, 36580.26839463209, 36621.81689091551, 36648.0, 7590.582517961496, 7757.961210193941, 7866.606669666522, 7878.054633443995, 7881.566513841736, 7591.848163036736, 7642.808929776745, 7696.268854458845, 7745.264199901028, 7794.532328060306, 7725.536467811921, 7864.724734634289, 7870.960645196795, 7874.094479134887, 7885.369170466378, 7757.379409647215, 7800.180980996999, 7829.765107046797, 7852.254035866641, 7861.056673199224, 7540.924590754077, 7649.847003059963, 7700.075990881074, 7722.845543089107, 7728.111267204287, 34442.13894652654, 34549.309013819584, 34758.304833903436, 34765.82617086898, 34859.65140348589, 2776.6806817215875, 2788.9581656275172, 3014.1861697341596, 3111.5177147542167, 3520.6479352064844, 26990.730092699214, 27076.59385109225, 27302.726972730416, 27310.317242068908, 27529.31176720578, 3253.544503769474, 3270.4930735735998, 3315.8010519368913, 3356.345512625039, 3416.9487457688156, 214616.0, 214770.0, 215930.0, 217454.0, 217502.0, 44472.0, 45488.0, 50083.24875126876, 51687.2246916289, 52439.0, 45581.0, 45657.31514027226, 45689.77155114203, 45726.085478290246, 45880.3117953231, 12532.624021279376, 12624.873751262554, 12639.87360126387, 12730.23618582888, 12753.68115797094, 9501.619935202514, 9524.714258572254, 9535.856962145574, 9580.856287155699, 9618.134367906921, 17153.0, 17619.119044047748, 17706.46880593584, 17796.3771268005, 17801.0, 7022.683979220948, 7185.209626941032, 7208.098987626547, 7209.639518024078, 7239.601821899846, 787.9724209652635, 841.9621117049747, 895.9104089591119, 958.2860768727203, 983.5131609853169, 25566.616500752505, 25735.871320643277, 26107.477850442883, 26144.8692756535, 26303.21090367292, 897.4615230861431, 912.885889263842, 935.8783358163395, 938.8216238914721, 976.092234222166, 13429.529966451128, 13493.392797324144, 13885.375158117708, 13985.3706583204, 14254.144751314954, 273577.0, 277389.0, 277871.0, 279322.0, 279423.0, 44260.3360949586, 44417.33373999393, 44450.0, 44461.55538444639, 44647.0, 1144.7080994346554, 1150.453534571072, 1153.3022521374614, 1159.913006524514, 1295.1710905020793, 25410.0, 25577.488450231263, 25619.871900640377, 25789.742102578733, 25927.61108583335, 38275.617243827204, 38661.22677546489, 38738.4189237156, 38783.612163878, 38835.805820971844, 257280.0, 258677.0, 259467.0, 260003.0, 261903.0, 26609.866950665124, 27643.170704878885, 28308.150755477367, 28322.0, 28605.28486787847, 33055.50416743799, 33066.834665826515, 34672.30655386928, 35276.64723352836, 35536.822315888254, 29855.253618659706, 30143.698563014088, 30591.388172235984, 30713.53929691101, 30764.230894227825, 28104.69870768093, 28264.15207543777, 28542.857285714268, 28584.428311434072, 29318.560221596268, 28644.283892902844, 28837.0, 28899.855500723203, 28907.855460723404, 29054.0, 26871.462570748867, 29075.7092429073, 29779.851100744356, 31133.532997005517, 32414.0, 21781.455463613536, 22880.771192287863, 22968.770312297333, 23040.4239894004, 23196.3041108767], "unit": "score", "name": "ext.html", "value": 15957.504469121988}, {"lowerIsBetter": false, "replicates": [328.4627941235021, 336.4448659711476, 337.52240579579893, 341.78638351030605, 343.0890984436322, 14029.649258768535, 14627.26863656817, 14899.32953017114, 14932.477363292286, 15713.371465141381, 8758.430702004365, 9007.144321289483, 10445.529951152197, 13856.445742170301, 13890.652733681638, 4212.052288235138, 4212.136512015045, 4396.252637051693, 4396.846110386137, 4413.271810151321, 4749.525047495257, 4753.928691069636, 4760.500147484516, 4765.7140571565815, 4768.666193366465, 3307.3219989902013, 3432.433648448003, 4599.770011499429, 4977.576905962997, 5987.341392446828, 6160.7535698572, 6312.116303717483, 6381.425671689523, 6386.904196437057, 6387.552871298988, 6113.113598528189, 6124.571280010401, 6131.264248290189, 6133.601315914451, 6137.9079313810325, 17825.554361140945, 19631.607367852564, 20632.0, 20721.481962950897, 20761.273355432488, 1867.175473643834, 1908.1127275816812, 1935.4870959195825, 2035.8880261585607, 2118.851680382374, 13025.283609401478, 13083.934580327037, 13340.533081342106, 13603.455861765517, 13633.113847599874, 1882.1436246507942, 1901.7622797150357, 1906.5805522785104, 1940.4760714607119, 1968.9901550492157, 52331.73834130843, 52683.270071256615, 53766.92466150694, 54176.72911635417, 54656.72671636656, 14343.78484322736, 14616.123032618078, 14637.560873173821, 14654.267286635626, 14684.85315146835, 21708.13167473315, 21779.564408711736, 21947.231846885283, 22031.0, 22037.126844218423, 7119.1457025157315, 7333.376662983706, 7346.11846578414, 7352.117745870422, 7442.106947166267, 5813.82558523245, 5842.707864606753, 5899.498542623839, 5917.289925209003, 5926.703664816742, 7157.606331651809, 7163.253813607873, 7279.12650481935, 7331.845712464057, 7408.555486670709, 2924.0350684274563, 2935.2074939766144, 2953.6898625644426, 2956.926076848096, 2982.388610334876, 319.5207189216176, 323.9174010627275, 324.4565353033659, 328.83886895421074, 351.67470090167006, 8569.700060497977, 8745.169208925143, 8857.557122143868, 8998.955005224932, 9107.726768196964, 342.3734565744731, 350.556545969349, 357.1963083063108, 364.6918353990873, 365.9012066742018, 4863.416390033219, 4938.950610493921, 5079.619028572872, 8477.533735644476, 8819.911800882037, 276728.0, 283674.0, 457780.0, 463646.0, 464106.0, 40103.0, 54481.1827822583, 60308.69845650744, 61668.0, 64342.678286608265, 1014.2089170446916, 1025.8102251083424, 1032.2825636182931, 1037.1547189040757, 1047.2145890582065, 13468.124571902796, 13605.795913061114, 13833.79249311241, 13908.582742517741, 13953.581392558239, 28415.573766393107, 29421.411571768873, 29759.404811904074, 30276.24309392283, 30695.2326191847, 37783.62216377801, 39024.02439939024, 39114.80442597769, 39273.8036309828, 39930.80034599808, 5847.736851841592, 5881.500072493886, 5889.38161493037, 5901.380355062656, 5915.733791979457, 6530.640814755234, 8841.646334146562, 8989.595468204077, 9152.084791521062, 9164.312676549418, 7965.402594805529, 8162.224588664068, 8351.498910065415, 8489.660413583388, 8590.14098590161, 8552.144785521647, 8576.871346929925, 8783.385163038525, 8871.157240062184, 8987.370884038317, 8647.0, 8730.257928076184, 8811.383203175716, 8816.382853200472, 8930.062343453843, 6328.810135695937, 6409.198850143732, 6436.742530298736, 6461.741530338733, 6484.059811327237, 7479.813004674927, 8794.42836215644, 8887.777805554913, 8947.731568052968, 9092.499912504876], "unit": "score", "name": "jquery.html", "value": 7327.127979889503}, {"lowerIsBetter": false, "replicates": [1364.4542183126748, 1370.8492065872756, 1471.4261438039166, 1661.410199379221, 1665.2506372132536, 5720.685362305072, 5834.533237341013, 6431.839204019896, 6578.967105164467, 6627.502937279699, 6451.225852897647, 6583.4074933256, 6647.567908085983, 6691.26396096429, 6692.631905245222, 1997.7902320256346, 2032.4512381656943, 2036.0227090996332, 2036.4297996560986, 2038.9490262743475, 1928.5757133430693, 1943.2615606069674, 1948.5713143108494, 1976.2589029114083, 1989.3832911797317, 2035.6539388304025, 2048.09883651193, 2052.435580215445, 2062.8762274263518, 2069.834413246944, 2023.6053969475959, 2026.6554685703466, 2027.432318950696, 2028.7464066991479, 2034.298167132337, 1985.9205631774712, 1987.7415935928382, 2044.8875311857842, 2050.446379477533, 2050.7436570428695, 6815.352541508549, 6861.176658800926, 6873.518853680244, 6896.689648965808, 6913.3777959983845, 3827.7129215308964, 3918.8432462701458, 3923.195744872294, 3930.194310166409, 3935.330993731073, 2635.64418803461, 2638.353603367168, 2702.189343197033, 2728.2088194423595, 2740.9588856167175, 822.6092606012096, 845.4124383553433, 861.4308495576068, 868.8349213649386, 870.7518357268211, 8927.107289271085, 8931.598078086501, 8936.687215947475, 8941.552922353856, 8950.552472376356, 3578.7315951303235, 3612.692921101683, 3624.3657359961903, 3637.690796282293, 3641.708663306929, 7752.534847909031, 7789.415793815373, 7799.33705635016, 7804.0635123785505, 7809.80475488106, 4045.696572757055, 4061.025353915098, 4062.4515690382013, 4063.9796801015805, 4080.836766529365, 3096.040227529473, 3174.587303650511, 3524.295140971765, 3701.9814900925862, 3750.587435382106, 3145.6697046810214, 3160.683931606821, 3162.304293055524, 3183.7453003759642, 3189.266468712209, 981.0336818234034, 982.5873133284038, 988.4810474500945, 988.851672249154, 991.1971303244395, 1080.206048554312, 1082.0748260237542, 1085.4898197846999, 1099.1042300525046, 1116.7543140509074, 5845.269341332333, 5848.766049357978, 5874.324452687995, 5889.558283128783, 6027.367126451747, 393.07038853112755, 1026.373911913732, 1065.6643157405392, 1084.8210045342587, 1098.4562641492512, 4604.217283061887, 4665.370175026396, 4686.250199968057, 4686.95313046872, 4702.153612349742, 7299.197088320387, 8008.27925486709, 8023.7994050148045, 8069.112397636255, 8083.353331733447, 7794.454388192886, 7811.68753249875, 7876.606169691492, 7940.960295198487, 7946.40401969843, 6334.619922804646, 6360.650164241011, 6455.354464553601, 6478.2873883872735, 6531.8367040823405, 5822.912656310074, 5863.882722345615, 5888.3228428731245, 5901.144334071621, 5903.763849445974, 7213.098362704662, 7237.710491580277, 7388.556686598607, 7425.740099096506, 7500.9249907500225, 7507.512011719221, 7615.0, 7623.390128789572, 7659.502132361378, 7719.459637825523, 4970.776315065903, 5076.36545431821, 5439.292891924025, 5483.75323110453, 5522.5581953442825, 5964.194833697569, 6094.878102437838, 6100.359462256399, 6100.908486372619, 6118.663473509, 5796.565257605612, 5895.616784908967, 6030.427109424598, 6075.483583895419, 6163.291221509584, 5766.826995190151, 5860.736266867916, 5861.384554621874, 5910.645361278337, 5921.615095018982, 5677.403872593318, 5788.652680839163, 5813.157092221689, 5824.126381042877, 5844.912326315024, 5243.973780131075, 5249.711265880261, 5266.447023062677, 5267.104592219409, 5270.8155214567305, 5552.167174923794, 5584.274044374368, 5589.748461319169, 5590.720463976866, 5599.32808063035], "unit": "score", "name": "mootools.html", "value": 3832.311110408248}, {"lowerIsBetter": false, "replicates": [275.8910230458969, 280.15672824797366, 283.4090920430902, 285.8085082994395, 290.0573137303763, 5395.81114660987, 5486.862828429291, 5528.253685752422, 5550.555955523553, 5565.137403702428, 5480.91778623321, 5484.095124304495, 5487.451254874511, 5496.945030549693, 5500.642458240211, 4184.979075104636, 4202.852900148496, 4227.302495088306, 4228.260054490467, 4231.640310573605, 4223.51429585597, 4227.196832601811, 4228.5982831630945, 4229.5981881721345, 4233.957660423387, 3959.3862951242604, 4082.5305089914596, 4184.832606695729, 4193.993441574015, 4195.769232692201, 4101.3847922811665, 4101.876943691694, 4108.055147316104, 4108.4864391951005, 4108.732932359402, 3491.458823882302, 3492.458668906298, 3492.738044646662, 3496.965030349689, 3497.9475307870403, 5206.635535512516, 5293.206019097166, 5321.787128514855, 5378.0, 5388.811391601314, 4745.738984355859, 4766.690165139289, 4772.260299653524, 4781.139394908915, 4785.9231672873675, 5874.3244526879525, 5875.764969401219, 5877.206577112078, 5880.294364676266, 5881.823545293648, 3794.772313661189, 3855.8072096395067, 3867.1105645701646, 3872.1674839909556, 3872.8257228424786, 6072.969635151796, 6134.8159555213415, 6159.692015399212, 6240.0, 6247.468965137969, 3958.980205098956, 3964.861229856941, 3973.9602603974167, 3985.8405663773706, 3987.461692671452, 4007.178528401729, 4029.6977726670616, 4037.899052523652, 4039.394090886332, 4043.555208927016, 4711.764411779397, 4716.103940251342, 4722.9763851181215, 4731.95268047322, 4739.526047395233, 5604.41153678866, 5662.17898404729, 5740.196372507852, 5765.423457654285, 5771.769129234867, 1393.414765798347, 1415.2216281045385, 1416.9291535423188, 1417.461364681435, 1423.501774378959, 908.9590968406437, 908.9909100908907, 924.075924075924, 925.0564424287189, 927.4667066436691, 4953.25701144824, 4966.751662416865, 4967.726775027336, 5004.974975125174, 5047.394312682428, 5955.970220148872, 5979.820605381846, 5985.16207730918, 5986.742784015319, 5988.371221021817, 5009.799608015712, 5014.398272207359, 5020.171671674206, 5022.0, 5028.622853286018, 3205.6634053424523, 3220.436423625856, 3251.089694885436, 3270.6238782540313, 3271.165852707544, 5703.458171473703, 5706.25818643582, 5707.1724599933605, 5708.4862362387585, 5723.914141287884, 6192.164057852222, 6238.594491358047, 6245.064030150668, 6245.375462453809, 6247.781327653511, 5562.054450743383, 5684.431556844283, 5720.256366672306, 5723.914141287884, 5729.0, 5962.970185149046, 6068.4841788448475, 6077.4226448487325, 6077.787277445268, 6089.786857459968, 5935.970320148372, 5938.257717785277, 5943.613665111754, 5949.929012777741, 5953.493953014043, 5648.830535083954, 5668.886622267449, 5692.203091567101, 5696.430356964271, 5703.657780533182, 3812.8474861005247, 3927.7054220934115, 3941.6452519273403, 3954.9406758898062, 3960.405939109157, 5997.13041608973, 6082.118092876596, 6094.75620975156, 6104.32852386246, 6170.629762214281, 5896.292444906467, 5900.940990590039, 5916.852078698067, 5930.703464826827, 5934.554908381802, 5849.883002340014, 5886.3525012247765, 5895.882082358415, 5908.409159084229, 5920.37836027211, 5584.916226256691, 5750.367459579359, 5767.826965191051, 5770.682612456355, 5771.624844385102, 5924.763009479572, 5934.940650593611, 5945.197398351167, 5954.612950158225, 5970.283565972111, 5770.538356931519, 5780.797672081457, 5782.826515204551, 5789.768409263583, 5796.884062318814], "unit": "score", "name": "prototype.html", "value": 4291.297904102315}, {"lowerIsBetter": false, "replicates": [630.3664816859057, 671.0672165689696, 728.0644371982004, 738.9187189409164, 767.4244316762432, 10844.837327440095, 10849.457527123643, 10880.891191088087, 10964.725881852948, 10992.450377481124, 12636.557720479785, 12895.226286422821, 12976.675583110427, 12992.610221693341, 13036.087473876809, 601.0983524712931, 604.8850718363519, 747.4095464582973, 759.5784339691469, 763.5952944939191, 742.476554029408, 747.178104085507, 753.7135888362442, 754.0273047768372, 754.6000619671555, 780.3172224303735, 782.8590853646341, 786.2216405758315, 788.4677842456348, 791.8495485857669, 771.9575423351713, 776.7164984780571, 776.7708525984848, 778.704092444873, 781.5076501803884, 577.9537636989031, 580.9564282678816, 584.8654809393821, 585.3356440440089, 587.0460501684762, 11695.239809412446, 11727.237729547638, 11746.236494627821, 11774.411279435993, 11776.234544754649, 10540.578376864993, 10726.678199654023, 10890.67327980154, 10890.836637450444, 10917.945410272978, 9689.854652180224, 9743.65897193602, 9763.951180244125, 9783.706488805346, 9860.704178874645, 3246.2209069823307, 3261.72275356595, 3268.2809781847955, 3293.571835661349, 3305.5537502437105, 37183.25633487342, 37684.81157594222, 37740.43389349162, 37775.0, 38420.42369364462, 9147.085291470932, 9250.074992500697, 9326.95336523313, 9379.765505862271, 9421.952890235505, 15072.924635376972, 15076.321565529577, 15087.396504139711, 15096.924515377354, 15106.320215590325, 6046.3651316612, 6145.477634401037, 6220.377962203834, 6284.4344009039405, 6286.0, 3662.6703596676425, 3712.276106159327, 3728.422094575345, 3777.7166712496673, 3819.7899115548357, 2595.532804095243, 2609.0346571768187, 2624.842509449439, 2630.07947218472, 2651.4034342272835, 482.80929033031754, 485.1848893858281, 489.33694843487274, 492.3918960084293, 492.9482404347492, 511.6955411530134, 547.1929102831684, 560.949514543693, 561.4161272276787, 564.266453610305, 7322.890156647654, 7480.812979675443, 7508.887366689504, 7593.278638529331, 7694.153643099255, 437.0952129092811, 464.8837790552362, 477.31743606642834, 514.565192412411, 575.3929604267454, 3400.59192896854, 3476.582810062758, 3502.9474557881654, 3571.4107172316794, 3579.1767893384144, 46866.5313346869, 47144.5285547147, 47212.7639361801, 47254.0, 47286.29070563944, 39258.41112383317, 39839.20321593552, 39866.20267594632, 39959.20489541274, 41395.793021034704, 38141.23717525634, 38169.80915095407, 38181.0, 39094.21811563753, 39143.217135657695, 7416.406687465098, 7626.9618651906385, 8117.512949223065, 8121.634526446443, 8343.833123337621, 28333.008344707836, 28497.28756781097, 28919.0, 29044.419111617226, 30205.09384718374, 36070.63929360673, 36976.44535332026, 37158.07104822401, 37253.62746372502, 37365.065873352294, 9621.90378096238, 9794.0, 9868.950655246677, 9889.703308900744, 10162.339447935861, 11167.609133680282, 11189.440527973406, 11374.545018199511, 11547.826782598437, 12175.75648487043, 10146.340487868265, 10148.575301910325, 10328.0, 10569.048785609331, 10677.09244714208, 10014.298999069995, 10184.338018028804, 10260.230482713976, 10324.174066074846, 10721.571137154426, 9714.3199976001, 9911.10800028001, 9925.305228633926, 9935.850962235716, 9960.800783984425, 8276.337892968428, 8372.41393102477, 8459.661613535389, 8463.957680211559, 8502.362322825937, 8420.326373889951, 8514.31885449175, 8543.487390756574, 8584.442011269248, 8759.824803504021], "unit": "score", "name": "yui.html", "value": 5502.106294491568}], "name": "dromaeo_css", "value": 6005.437157466278}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 115.0, 115.0, 116.0, 125.0, 114.0, 115.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [157.0, 141.0, 165.0, 168.0, 144.0, 154.0, 155.0, 140.0, 180.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 153.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 165.0, 162.0, 172.0, 162.0, 160.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 74.0, 140.0, 74.0, 73.0, 72.0, 72.0, 151.0], "unit": "score", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 143.0, 97.0, 98.0, 98.0, 137.0, 98.0, 98.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 69.0, 68.0, 70.0, 70.0, 77.0, 67.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 70.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 67.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 86.0, 86.0, 86.0, 88.0, 85.0, 91.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 122.0, 129.0, 120.0, 135.0, 122.0, 123.0, 139.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [139.0, 147.0, 147.0, 137.0, 158.0, 134.0, 147.0, 152.0, 142.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [74.0, 70.0, 70.0, 71.0, 71.0, 69.0, 70.0, 78.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1548.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [186.35855385762207], "unit": "score", "name": "DeltaBlue", "value": 354.7891880000001}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1082.162162162162], "unit": "score", "name": "RayTrace", "value": 683.8060189810188}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12432.098765432098], "unit": "score", "name": "Boyer", "value": 53.608245283018846}, {"lowerIsBetter": false, "replicates": [43937.5], "unit": "score", "name": "RegExp", "value": 20.733655761024178}, {"lowerIsBetter": false, "replicates": [594.5303210463734], "unit": "score", "name": "Splay", "value": 137.06786199999996}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20246.819576933354}]} 15:34:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20246.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1548.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6005.44"}}} 15:34:07 INFO - Return code: 0 15:34:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:34:07 INFO - # TBPL SUCCESS # 15:34:07 INFO - Running post-action listener: _resource_record_post_action 15:34:07 INFO - Running post-run listener: _resource_record_post_run 15:34:08 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 581632; Write bytes: 321343488; Read time: 80; Write time: 256564 15:34:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14233600; Read time: 0; Write time: 1852 15:34:08 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 581632; Write bytes: 307109888; Read time: 80; Write time: 254712 15:34:08 INFO - Running post-run listener: _upload_blobber_files 15:34:08 INFO - Blob upload gear active. 15:34:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:34:08 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:34:08 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:34:08 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:34:08 INFO - (blobuploader) - INFO - Open directory for files ... 15:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:34:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:09 INFO - (blobuploader) - INFO - Done attempting. 15:34:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:34:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:34:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:10 INFO - (blobuploader) - INFO - Done attempting. 15:34:10 INFO - (blobuploader) - INFO - Iteration through files over. 15:34:10 INFO - Return code: 0 15:34:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:34:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:34:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c8bd1956914967848dfaa125f4b4100c32139e35631de09290123aca575fa69dccbbd2dd946eb814375c76c075d4a03c67724459fe83e47e923c3b7b35a47ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/972929a603bc1c3bdece0b32af73e688747551bdea560c36a5a5524ac9dad28ee1fec0be921d52933ea68c917282110d69500208e02772b652eccb3adcdb698c"} 15:34:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:34:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:34:10 INFO - Contents: 15:34:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c8bd1956914967848dfaa125f4b4100c32139e35631de09290123aca575fa69dccbbd2dd946eb814375c76c075d4a03c67724459fe83e47e923c3b7b35a47ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/972929a603bc1c3bdece0b32af73e688747551bdea560c36a5a5524ac9dad28ee1fec0be921d52933ea68c917282110d69500208e02772b652eccb3adcdb698c"} 15:34:10 INFO - Running post-run listener: copy_logs_to_upload_dir 15:34:10 INFO - Copying logs to upload dir... 15:34:10 INFO - mkdir: /builds/slave/test/build/upload/logs 15:34:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1312.633380 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2016-01-16 15:34:10.476826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 15:34:10.481165) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 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/4c8bd1956914967848dfaa125f4b4100c32139e35631de09290123aca575fa69dccbbd2dd946eb814375c76c075d4a03c67724459fe83e47e923c3b7b35a47ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/972929a603bc1c3bdece0b32af73e688747551bdea560c36a5a5524ac9dad28ee1fec0be921d52933ea68c917282110d69500208e02772b652eccb3adcdb698c"} build_url:https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/BGEWIVpDRXmT4wlvT7omnw/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/4c8bd1956914967848dfaa125f4b4100c32139e35631de09290123aca575fa69dccbbd2dd946eb814375c76c075d4a03c67724459fe83e47e923c3b7b35a47ac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/972929a603bc1c3bdece0b32af73e688747551bdea560c36a5a5524ac9dad28ee1fec0be921d52933ea68c917282110d69500208e02772b652eccb3adcdb698c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 15:34:10.512138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 15:34:10.512844) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452978460.443119-1481658069 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 15:34:10.595235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 15:34:10.596434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 15:34:10.597640) ========= ========= Total master_lag: 0.35 =========