builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1467768568.81 results: success (0) buildid: 20160705171131 builduid: e1d2d9d5871b41a19cf332977e01f077 revision: 70e05c6832e831374604ac3ce7433971368dffe0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:28.809891) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:28.810307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:28.810636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:28.867332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:28.867621) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 18:29:28-- 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% 43.6M=0s 2016-07-05 18:29:29 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144855 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.063584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.063868) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.121392 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.197288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.197632) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 70e05c6832e831374604ac3ce7433971368dffe0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 70e05c6832e831374604ac3ce7433971368dffe0 --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=e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 18:29:29,259 truncating revision to first 12 chars 2016-07-05 18:29:29,259 Setting DEBUG logging. 2016-07-05 18:29:29,259 attempt 1/10 2016-07-05 18:29:29,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/70e05c6832e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 18:29:29,558 unpacking tar archive at: mozilla-central-70e05c6832e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.862859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.863184) ========= script_repo_revision: 70e05c6832e831374604ac3ce7433971368dffe0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.863612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.863887) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 18:29:29.874683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-05 18:29:29.874966) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:30 INFO - MultiFileLogger online at 20160705 18:29:30 in /builds/slave/test 18:29:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:29:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:30 INFO - {'append_to_log': False, 18:29:30 INFO - 'base_work_dir': '/builds/slave/test', 18:29:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:29:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:30 INFO - 'branch': 'Firefox-Non-PGO', 18:29:30 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:30 INFO - 'config_files': ('talos/linux_config.py',), 18:29:30 INFO - 'default_actions': ('clobber', 18:29:30 INFO - 'read-buildbot-config', 18:29:30 INFO - 'download-and-extract', 18:29:30 INFO - 'populate-webroot', 18:29:30 INFO - 'create-virtualenv', 18:29:30 INFO - 'install', 18:29:30 INFO - 'run-tests'), 18:29:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:30 INFO - 'download_minidump_stackwalk': True, 18:29:30 INFO - 'download_symbols': 'ondemand', 18:29:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:30 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:30 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:30 INFO - 'installer_path': 'installer.exe', 18:29:30 INFO - 'log_level': 'info', 18:29:30 INFO - 'log_name': 'talos', 18:29:30 INFO - 'log_to_console': True, 18:29:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:30 INFO - 'opt_config_files': (), 18:29:30 INFO - 'pip_index': False, 18:29:30 INFO - 'sps_profile': False, 18:29:30 INFO - 'sps_profile_interval': 0, 18:29:30 INFO - 'suite': 'dromaeojs-e10s', 18:29:30 INFO - 'system_bits': '32', 18:29:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:30 INFO - 'title': 'talos-linux64-ix-067', 18:29:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:30 INFO - 'use_talos_json': True, 18:29:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:30 INFO - 'work_dir': 'build'} 18:29:30 INFO - ##### 18:29:30 INFO - ##### Running clobber step. 18:29:30 INFO - ##### 18:29:30 INFO - Running pre-action listener: _resource_record_pre_action 18:29:30 INFO - Running main action method: clobber 18:29:30 INFO - rmtree: /builds/slave/test/build 18:29:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:30 INFO - Running post-action listener: _resource_record_post_action 18:29:30 INFO - ##### 18:29:30 INFO - ##### Finished clobber step (success) 18:29:30 INFO - ##### 18:29:30 INFO - ##### 18:29:30 INFO - ##### Running read-buildbot-config step. 18:29:30 INFO - ##### 18:29:30 INFO - Running pre-action listener: _resource_record_pre_action 18:29:30 INFO - Running main action method: read_buildbot_config 18:29:30 INFO - Using buildbot properties: 18:29:30 INFO - { 18:29:30 INFO - "project": "", 18:29:30 INFO - "product": "firefox", 18:29:30 INFO - "script_repo_revision": "production", 18:29:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:29:30 INFO - "repository": "", 18:29:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:29:30 INFO - "buildid": "20160705171131", 18:29:30 INFO - "pgo_build": "False", 18:29:30 INFO - "basedir": "/builds/slave/test", 18:29:30 INFO - "buildnumber": 391, 18:29:30 INFO - "slavename": "talos-linux64-ix-067", 18:29:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:29:30 INFO - "platform": "ubuntu64_hw", 18:29:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:29:30 INFO - "branch": "mozilla-central", 18:29:30 INFO - "repo_path": "mozilla-central", 18:29:30 INFO - "revision": "70e05c6832e831374604ac3ce7433971368dffe0", 18:29:30 INFO - "stage_platform": "linux64", 18:29:30 INFO - "builduid": "e1d2d9d5871b41a19cf332977e01f077", 18:29:30 INFO - "slavebuilddir": "test" 18:29:30 INFO - } 18:29:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:29:30 INFO - Running post-action listener: _resource_record_post_action 18:29:30 INFO - ##### 18:29:30 INFO - ##### Finished read-buildbot-config step (success) 18:29:30 INFO - ##### 18:29:30 INFO - ##### 18:29:30 INFO - ##### Running download-and-extract step. 18:29:30 INFO - ##### 18:29:30 INFO - Running pre-action listener: _resource_record_pre_action 18:29:30 INFO - Running main action method: download_and_extract 18:29:30 INFO - mkdir: /builds/slave/test/build/tests 18:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:30 INFO - https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:29:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:29:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:29:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:29:34 INFO - Downloaded 1361 bytes. 18:29:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:29:34 INFO - Using the following test package requirements: 18:29:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:29:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:29:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:34 INFO - u'jsshell-linux-x86_64.zip'], 18:29:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:29:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:29:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:29:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:29:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:29:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:34 INFO - https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:29:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:29:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:29:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:29:44 INFO - Downloaded 22731017 bytes. 18:29:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:29:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:29:45 INFO - Return code: 0 18:29:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:45 INFO - https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:29:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:29:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:29:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:29:46 INFO - Downloaded 22731017 bytes. 18:29:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:29:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:29:47 INFO - Return code: 0 18:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:47 INFO - https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:29:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:29:48 INFO - Downloaded 14403333 bytes. 18:29:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:29:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:29:48 INFO - Return code: 0 18:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:49 INFO - https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:29:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:29:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:29:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:29:50 INFO - Downloaded 56504138 bytes. 18:29:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:29:50 INFO - mkdir: /builds/slave/test/properties 18:29:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:29:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:29:50 INFO - Contents: 18:29:50 INFO - build_url:https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:29:51 INFO - Running post-action listener: _resource_record_post_action 18:29:51 INFO - Running post-action listener: set_extra_try_arguments 18:29:51 INFO - ##### 18:29:51 INFO - ##### Finished download-and-extract step (success) 18:29:51 INFO - ##### 18:29:51 INFO - ##### 18:29:51 INFO - ##### Running populate-webroot step. 18:29:51 INFO - ##### 18:29:51 INFO - Running pre-action listener: _resource_record_pre_action 18:29:51 INFO - Running main action method: populate_webroot 18:29:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:29:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:29:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:29:51 INFO - '--tppagecycles', 18:29:51 INFO - '7'], 18:29:51 INFO - 'tests': ['tsvgm']}}, 18:29:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:29:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:29:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:29:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:29:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['damp', 'tps']}, 18:29:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'tests': ['damp', 'tps']}, 18:29:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['dromaeo_dom']}, 18:29:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:29:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['basic_compositor_video']}, 18:29:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:29:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore', 18:29:51 INFO - 'tabpaint']}, 18:29:51 INFO - 'other-e10s': {'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore', 18:29:51 INFO - 'tabpaint']}, 18:29:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore', 18:29:51 INFO - 'tabpaint']}, 18:29:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore', 18:29:51 INFO - 'tabpaint']}, 18:29:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore', 18:29:51 INFO - 'tabpaint']}, 18:29:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['a11yr', 18:29:51 INFO - 'ts_paint', 18:29:51 INFO - 'tpaint', 18:29:51 INFO - 'sessionrestore', 18:29:51 INFO - 'sessionrestore_no_auto_restore', 18:29:51 INFO - 'tabpaint']}, 18:29:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['tsvgx', 18:29:51 INFO - 'tsvgr_opacity', 18:29:51 INFO - 'tart', 18:29:51 INFO - 'tscrollx', 18:29:51 INFO - 'cart']}, 18:29:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:29:51 INFO - 'tsvgr_opacity', 18:29:51 INFO - 'tart', 18:29:51 INFO - 'tscrollx', 18:29:51 INFO - 'cart']}, 18:29:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--disable-e10s'], 18:29:51 INFO - 'tests': ['tp5o']}, 18:29:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'tests': ['tp5o']}, 18:29:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--disable-e10s', 18:29:51 INFO - '--xperf_path', 18:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:51 INFO - 'tests': ['tp5n']}, 18:29:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:51 INFO - 'talos_options': ['--xperf_path', 18:29:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:51 INFO - 'tests': ['tp5n']}}, 18:29:51 INFO - 'talos.zip': {'path': '', 18:29:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:29:51 INFO - Running post-action listener: _resource_record_post_action 18:29:51 INFO - ##### 18:29:51 INFO - ##### Finished populate-webroot step (success) 18:29:51 INFO - ##### 18:29:51 INFO - ##### 18:29:51 INFO - ##### Running create-virtualenv step. 18:29:51 INFO - ##### 18:29:51 INFO - Running pre-action listener: _resource_record_pre_action 18:29:51 INFO - Running main action method: create_virtualenv 18:29:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:29:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:29:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:29:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:29:51 INFO - Using real prefix '/usr' 18:29:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:29:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:29:54 INFO - Installing pip.................done. 18:29:54 INFO - Return code: 0 18:29:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:29:54 INFO - Using env: {'DISPLAY': ':0', 18:29:54 INFO - 'HOME': '/home/cltbld', 18:29:54 INFO - 'LANG': 'en_US.UTF-8', 18:29:54 INFO - 'LANGUAGE': 'en_US:en', 18:29:54 INFO - 'LOGNAME': 'cltbld', 18:29:54 INFO - 'MAIL': '/var/mail/cltbld', 18:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:54 INFO - 'MOZ_NO_REMOTE': '1', 18:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:54 INFO - 'NO_EM_RESTART': '1', 18:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:54 INFO - 'PWD': '/builds/slave/test', 18:29:54 INFO - 'SHELL': '/bin/bash', 18:29:54 INFO - 'SHLVL': '1', 18:29:54 INFO - 'TERM': 'linux', 18:29:54 INFO - 'TMOUT': '86400', 18:29:54 INFO - 'USER': 'cltbld', 18:29:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:54 INFO - '_': '/tools/buildbot/bin/python'} 18:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:29:54 INFO - Cleaning up... 18:29:54 INFO - Return code: 0 18:29:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 18:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 18:29:54 INFO - Using env: {'DISPLAY': ':0', 18:29:54 INFO - 'HOME': '/home/cltbld', 18:29:54 INFO - 'LANG': 'en_US.UTF-8', 18:29:54 INFO - 'LANGUAGE': 'en_US:en', 18:29:54 INFO - 'LOGNAME': 'cltbld', 18:29:54 INFO - 'MAIL': '/var/mail/cltbld', 18:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:54 INFO - 'MOZ_NO_REMOTE': '1', 18:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:54 INFO - 'NO_EM_RESTART': '1', 18:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:54 INFO - 'PWD': '/builds/slave/test', 18:29:54 INFO - 'SHELL': '/bin/bash', 18:29:54 INFO - 'SHLVL': '1', 18:29:54 INFO - 'TERM': 'linux', 18:29:54 INFO - 'TMOUT': '86400', 18:29:54 INFO - 'USER': 'cltbld', 18:29:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:54 INFO - '_': '/tools/buildbot/bin/python'} 18:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:54 INFO - Downloading/unpacking psutil>=3.1.1 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:29:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:56 INFO - Installing collected packages: psutil 18:29:56 INFO - Running setup.py install for psutil 18:29:56 INFO - building 'psutil._psutil_linux' extension 18:29:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:29:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:29:57 INFO - building 'psutil._psutil_posix' extension 18:29:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:29:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:29:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:58 INFO - Successfully installed psutil 18:29:58 INFO - Cleaning up... 18:29:58 INFO - Return code: 0 18:29:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:29:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 18:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 18:29:58 INFO - Using env: {'DISPLAY': ':0', 18:29:58 INFO - 'HOME': '/home/cltbld', 18:29:58 INFO - 'LANG': 'en_US.UTF-8', 18:29:58 INFO - 'LANGUAGE': 'en_US:en', 18:29:58 INFO - 'LOGNAME': 'cltbld', 18:29:58 INFO - 'MAIL': '/var/mail/cltbld', 18:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:58 INFO - 'MOZ_NO_REMOTE': '1', 18:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:58 INFO - 'NO_EM_RESTART': '1', 18:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:58 INFO - 'PWD': '/builds/slave/test', 18:29:58 INFO - 'SHELL': '/bin/bash', 18:29:58 INFO - 'SHLVL': '1', 18:29:58 INFO - 'TERM': 'linux', 18:29:58 INFO - 'TMOUT': '86400', 18:29:58 INFO - 'USER': 'cltbld', 18:29:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:58 INFO - '_': '/tools/buildbot/bin/python'} 18:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:30:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:30:00 INFO - Installing collected packages: mozsystemmonitor 18:30:00 INFO - Running setup.py install for mozsystemmonitor 18:30:00 INFO - Successfully installed mozsystemmonitor 18:30:00 INFO - Cleaning up... 18:30:00 INFO - Return code: 0 18:30:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 18:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 18:30:00 INFO - Using env: {'DISPLAY': ':0', 18:30:00 INFO - 'HOME': '/home/cltbld', 18:30:00 INFO - 'LANG': 'en_US.UTF-8', 18:30:00 INFO - 'LANGUAGE': 'en_US:en', 18:30:00 INFO - 'LOGNAME': 'cltbld', 18:30:00 INFO - 'MAIL': '/var/mail/cltbld', 18:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:00 INFO - 'MOZ_NO_REMOTE': '1', 18:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:00 INFO - 'NO_EM_RESTART': '1', 18:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:00 INFO - 'PWD': '/builds/slave/test', 18:30:00 INFO - 'SHELL': '/bin/bash', 18:30:00 INFO - 'SHLVL': '1', 18:30:00 INFO - 'TERM': 'linux', 18:30:00 INFO - 'TMOUT': '86400', 18:30:00 INFO - 'USER': 'cltbld', 18:30:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:00 INFO - '_': '/tools/buildbot/bin/python'} 18:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:00 INFO - Downloading/unpacking jsonschema==2.5.1 18:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:02 INFO - warning: no files found matching '*.txt' 18:30:02 INFO - no previously-included directories found matching 'build' 18:30:02 INFO - no previously-included directories found matching 'dist' 18:30:02 INFO - no previously-included directories found matching '.git*' 18:30:02 INFO - Installing collected packages: jsonschema, functools32 18:30:02 INFO - Running setup.py install for functools32 18:30:02 INFO - warning: no files found matching '*.txt' 18:30:02 INFO - no previously-included directories found matching 'build' 18:30:02 INFO - no previously-included directories found matching 'dist' 18:30:02 INFO - no previously-included directories found matching '.git*' 18:30:02 INFO - Successfully installed jsonschema functools32 18:30:02 INFO - Cleaning up... 18:30:03 INFO - Return code: 0 18:30:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:30:03 INFO - Using env: {'DISPLAY': ':0', 18:30:03 INFO - 'HOME': '/home/cltbld', 18:30:03 INFO - 'LANG': 'en_US.UTF-8', 18:30:03 INFO - 'LANGUAGE': 'en_US:en', 18:30:03 INFO - 'LOGNAME': 'cltbld', 18:30:03 INFO - 'MAIL': '/var/mail/cltbld', 18:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:03 INFO - 'MOZ_NO_REMOTE': '1', 18:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:03 INFO - 'NO_EM_RESTART': '1', 18:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:03 INFO - 'PWD': '/builds/slave/test', 18:30:03 INFO - 'SHELL': '/bin/bash', 18:30:03 INFO - 'SHLVL': '1', 18:30:03 INFO - 'TERM': 'linux', 18:30:03 INFO - 'TMOUT': '86400', 18:30:03 INFO - 'USER': 'cltbld', 18:30:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:03 INFO - '_': '/tools/buildbot/bin/python'} 18:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:30:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:05 INFO - Downloading docopt-0.6.1.tar.gz 18:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:05 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:05 INFO - Running setup.py install for blobuploader 18:30:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:30:06 INFO - Running setup.py install for requests 18:30:06 INFO - Running setup.py install for docopt 18:30:06 INFO - Successfully installed blobuploader requests docopt 18:30:06 INFO - Cleaning up... 18:30:06 INFO - Return code: 0 18:30:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:06 INFO - Using env: {'DISPLAY': ':0', 18:30:06 INFO - 'HOME': '/home/cltbld', 18:30:06 INFO - 'LANG': 'en_US.UTF-8', 18:30:06 INFO - 'LANGUAGE': 'en_US:en', 18:30:06 INFO - 'LOGNAME': 'cltbld', 18:30:06 INFO - 'MAIL': '/var/mail/cltbld', 18:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:06 INFO - 'MOZ_NO_REMOTE': '1', 18:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:06 INFO - 'NO_EM_RESTART': '1', 18:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:06 INFO - 'PWD': '/builds/slave/test', 18:30:06 INFO - 'SHELL': '/bin/bash', 18:30:06 INFO - 'SHLVL': '1', 18:30:06 INFO - 'TERM': 'linux', 18:30:06 INFO - 'TMOUT': '86400', 18:30:06 INFO - 'USER': 'cltbld', 18:30:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:06 INFO - '_': '/tools/buildbot/bin/python'} 18:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:06 INFO - Running setup.py (path:/tmp/pip-JE_Krj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:06 INFO - Running setup.py (path:/tmp/pip-AFjH0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:06 INFO - Running setup.py (path:/tmp/pip-HApdVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:06 INFO - Running setup.py (path:/tmp/pip-NT0l_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:07 INFO - Running setup.py (path:/tmp/pip-Jx87mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:07 INFO - Running setup.py (path:/tmp/pip-LxPFvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:07 INFO - Running setup.py (path:/tmp/pip-cSrgeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:07 INFO - Running setup.py (path:/tmp/pip-rJvNRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:07 INFO - Running setup.py (path:/tmp/pip-KJ3LbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:07 INFO - Running setup.py (path:/tmp/pip-6bB4tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:07 INFO - Running setup.py (path:/tmp/pip-kkTy97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:07 INFO - Running setup.py (path:/tmp/pip-mzn3r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:07 INFO - Running setup.py (path:/tmp/pip-98dN0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:07 INFO - Running setup.py (path:/tmp/pip-Y6sYl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:07 INFO - Running setup.py (path:/tmp/pip-rPZCGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:07 INFO - Running setup.py (path:/tmp/pip-7Sbynt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:07 INFO - Running setup.py (path:/tmp/pip-I9_TOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:07 INFO - Running setup.py install for manifestparser 18:30:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Running setup.py install for mozcrash 18:30:08 INFO - Running setup.py install for mozdebug 18:30:08 INFO - Running setup.py install for mozdevice 18:30:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Running setup.py install for mozfile 18:30:08 INFO - Running setup.py install for mozhttpd 18:30:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Running setup.py install for mozinfo 18:30:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Running setup.py install for mozInstall 18:30:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:08 INFO - Running setup.py install for mozleak 18:30:08 INFO - Running setup.py install for mozlog 18:30:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for moznetwork 18:30:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for mozprocess 18:30:09 INFO - Running setup.py install for mozprofile 18:30:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for mozrunner 18:30:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Running setup.py install for mozscreenshot 18:30:09 INFO - Running setup.py install for moztest 18:30:09 INFO - Running setup.py install for mozversion 18:30:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:09 INFO - Cleaning up... 18:30:09 INFO - Return code: 0 18:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:09 INFO - Using env: {'DISPLAY': ':0', 18:30:09 INFO - 'HOME': '/home/cltbld', 18:30:09 INFO - 'LANG': 'en_US.UTF-8', 18:30:09 INFO - 'LANGUAGE': 'en_US:en', 18:30:09 INFO - 'LOGNAME': 'cltbld', 18:30:09 INFO - 'MAIL': '/var/mail/cltbld', 18:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:09 INFO - 'MOZ_NO_REMOTE': '1', 18:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:09 INFO - 'NO_EM_RESTART': '1', 18:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:09 INFO - 'PWD': '/builds/slave/test', 18:30:09 INFO - 'SHELL': '/bin/bash', 18:30:09 INFO - 'SHLVL': '1', 18:30:09 INFO - 'TERM': 'linux', 18:30:09 INFO - 'TMOUT': '86400', 18:30:09 INFO - 'USER': 'cltbld', 18:30:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:09 INFO - '_': '/tools/buildbot/bin/python'} 18:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:10 INFO - Running setup.py (path:/tmp/pip-FVsQsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:10 INFO - Running setup.py (path:/tmp/pip-aiEbl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:10 INFO - Running setup.py (path:/tmp/pip-8l7_pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:10 INFO - Running setup.py (path:/tmp/pip-f_PpmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:10 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)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:10 INFO - Running setup.py (path:/tmp/pip-av02Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:10 INFO - Running setup.py (path:/tmp/pip-Zorrv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:10 INFO - Running setup.py (path:/tmp/pip-YeQSLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:10 INFO - Running setup.py (path:/tmp/pip-kmiRHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:10 INFO - Running setup.py (path:/tmp/pip-GPMrHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:10 INFO - Running setup.py (path:/tmp/pip-I3btWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:10 INFO - Running setup.py (path:/tmp/pip-tRzjbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:10 INFO - Running setup.py (path:/tmp/pip-9M8zER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:10 INFO - Running setup.py (path:/tmp/pip-KnLvCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:10 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)) 18:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:10 INFO - Running setup.py (path:/tmp/pip-dsGkUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:11 INFO - Running setup.py (path:/tmp/pip-a1382g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:11 INFO - Running setup.py (path:/tmp/pip-i80PGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:11 INFO - Running setup.py (path:/tmp/pip-dZrdPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:30:11 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:30:11 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)) 18:30:11 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)) 18:30:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:13 INFO - Downloading blessings-1.6.tar.gz 18:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:13 INFO - Installing collected packages: blessings 18:30:13 INFO - Running setup.py install for blessings 18:30:13 INFO - Successfully installed blessings 18:30:13 INFO - Cleaning up... 18:30:13 INFO - Return code: 0 18:30:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:13 INFO - Reading from file tmpfile_stdout 18:30:13 INFO - Current package versions: 18:30:13 INFO - argparse == 1.2.1 18:30:13 INFO - blessings == 1.6 18:30:13 INFO - blobuploader == 1.2.4 18:30:13 INFO - docopt == 0.6.1 18:30:13 INFO - functools32 == 3.2.3-2 18:30:13 INFO - jsonschema == 2.5.1 18:30:13 INFO - manifestparser == 1.1 18:30:13 INFO - mozInstall == 1.12 18:30:13 INFO - mozcrash == 0.17 18:30:13 INFO - mozdebug == 0.1 18:30:13 INFO - mozdevice == 0.48 18:30:13 INFO - mozfile == 1.2 18:30:13 INFO - mozhttpd == 0.7 18:30:13 INFO - mozinfo == 0.9 18:30:13 INFO - mozleak == 0.1 18:30:13 INFO - mozlog == 3.2 18:30:13 INFO - moznetwork == 0.27 18:30:13 INFO - mozprocess == 0.22 18:30:13 INFO - mozprofile == 0.28 18:30:13 INFO - mozrunner == 6.11 18:30:13 INFO - mozscreenshot == 0.1 18:30:13 INFO - mozsystemmonitor == 0.3 18:30:13 INFO - moztest == 0.7 18:30:13 INFO - mozversion == 1.4 18:30:13 INFO - psutil == 3.1.1 18:30:13 INFO - requests == 1.2.3 18:30:13 INFO - wsgiref == 0.1.2 18:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:13 INFO - Using env: {'DISPLAY': ':0', 18:30:13 INFO - 'HOME': '/home/cltbld', 18:30:13 INFO - 'LANG': 'en_US.UTF-8', 18:30:13 INFO - 'LANGUAGE': 'en_US:en', 18:30:13 INFO - 'LOGNAME': 'cltbld', 18:30:13 INFO - 'MAIL': '/var/mail/cltbld', 18:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:13 INFO - 'MOZ_NO_REMOTE': '1', 18:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:13 INFO - 'NO_EM_RESTART': '1', 18:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:13 INFO - 'PWD': '/builds/slave/test', 18:30:13 INFO - 'SHELL': '/bin/bash', 18:30:13 INFO - 'SHLVL': '1', 18:30:13 INFO - 'TERM': 'linux', 18:30:13 INFO - 'TMOUT': '86400', 18:30:13 INFO - 'USER': 'cltbld', 18:30:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:13 INFO - '_': '/tools/buildbot/bin/python'} 18:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 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)) 18:30:13 INFO - Cleaning up... 18:30:13 INFO - Return code: 0 18:30:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1c98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:30:13 INFO - Using env: {'DISPLAY': ':0', 18:30:13 INFO - 'HOME': '/home/cltbld', 18:30:13 INFO - 'LANG': 'en_US.UTF-8', 18:30:13 INFO - 'LANGUAGE': 'en_US:en', 18:30:13 INFO - 'LOGNAME': 'cltbld', 18:30:13 INFO - 'MAIL': '/var/mail/cltbld', 18:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:13 INFO - 'MOZ_NO_REMOTE': '1', 18:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:13 INFO - 'NO_EM_RESTART': '1', 18:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:13 INFO - 'PWD': '/builds/slave/test', 18:30:13 INFO - 'SHELL': '/bin/bash', 18:30:13 INFO - 'SHLVL': '1', 18:30:13 INFO - 'TERM': 'linux', 18:30:13 INFO - 'TMOUT': '86400', 18:30:13 INFO - 'USER': 'cltbld', 18:30:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:13 INFO - '_': '/tools/buildbot/bin/python'} 18:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:30:14 INFO - Cleaning up... 18:30:14 INFO - Return code: 0 18:30:14 INFO - Running post-action listener: _resource_record_post_action 18:30:14 INFO - Running post-action listener: _start_resource_monitoring 18:30:14 INFO - Starting resource monitoring. 18:30:14 INFO - ##### 18:30:14 INFO - ##### Finished create-virtualenv step (success) 18:30:14 INFO - ##### 18:30:14 INFO - ##### 18:30:14 INFO - ##### Running install step. 18:30:14 INFO - ##### 18:30:14 INFO - Running pre-action listener: _resource_record_pre_action 18:30:14 INFO - Running main action method: install 18:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:14 INFO - Reading from file tmpfile_stdout 18:30:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:14 INFO - Reading from file tmpfile_stdout 18:30:14 INFO - Output received: 18:30:14 INFO - Usage: mozinstall [options] installer 18:30:14 INFO - Options: 18:30:14 INFO - -h, --help show this help message and exit 18:30:14 INFO - -d DEST, --destination=DEST 18:30:14 INFO - Directory to install application into. [default: 18:30:14 INFO - "/builds/slave/test"] 18:30:14 INFO - --app=APP Application being installed. [default: firefox] 18:30:14 INFO - mkdir: /builds/slave/test/build/application 18:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:30:30 INFO - Reading from file tmpfile_stdout 18:30:30 INFO - Output received: 18:30:30 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:30 INFO - Running post-action listener: _resource_record_post_action 18:30:30 INFO - ##### 18:30:30 INFO - ##### Finished install step (success) 18:30:30 INFO - ##### 18:30:30 INFO - ##### 18:30:30 INFO - ##### Running run-tests step. 18:30:30 INFO - ##### 18:30:30 INFO - Running pre-action listener: _resource_record_pre_action 18:30:30 INFO - Running main action method: run_tests 18:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:30 INFO - Python 2.7.3 18:30:30 INFO - Return code: 0 18:30:30 INFO - grabbing minidump binary from tooltool 18:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:30 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f56570>, '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 0x1f57470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:30:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:30:30 INFO - Calling ['/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'] with output_timeout 600 18:30:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:30 INFO - Return code: 0 18:30:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 18:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 18:30:30 INFO - Using env: {'DISPLAY': ':0', 18:30:30 INFO - 'HOME': '/home/cltbld', 18:30:30 INFO - 'LANG': 'en_US.UTF-8', 18:30:30 INFO - 'LANGUAGE': 'en_US:en', 18:30:30 INFO - 'LOGNAME': 'cltbld', 18:30:30 INFO - 'MAIL': '/var/mail/cltbld', 18:30:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:30 INFO - 'MOZ_NO_REMOTE': '1', 18:30:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:30 INFO - 'NO_EM_RESTART': '1', 18:30:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:30 INFO - 'PWD': '/builds/slave/test', 18:30:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:30 INFO - 'SHELL': '/bin/bash', 18:30:30 INFO - 'SHLVL': '1', 18:30:30 INFO - 'TERM': 'linux', 18:30:30 INFO - 'TMOUT': '86400', 18:30:30 INFO - 'USER': 'cltbld', 18:30:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277', 18:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:30 INFO - '_': '/tools/buildbot/bin/python'} 18:30:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 18:30:30 INFO - mozversion application_buildid: 20160705171131 18:30:30 INFO - mozversion application_changeset: 70e05c6832e831374604ac3ce7433971368dffe0 18:30:30 INFO - mozversion application_display_name: Nightly 18:30:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:30 INFO - mozversion application_name: Firefox 18:30:30 INFO - mozversion application_remotingname: firefox 18:30:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:30:30 INFO - mozversion application_vendor: Mozilla 18:30:30 INFO - mozversion application_version: 50.0a1 18:30:30 INFO - mozversion platform_buildid: 20160705171131 18:30:30 INFO - mozversion platform_changeset: 70e05c6832e831374604ac3ce7433971368dffe0 18:30:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:30:30 INFO - mozversion platform_version: 50.0a1 18:30:30 INFO - using testdate: 1467768630 18:30:30 INFO - actual date: 1467768630 18:30:30 INFO - starting webserver on 'localhost:33262' 18:30:30 INFO - SUITE-START | Running 2 tests 18:30:30 INFO - TEST-START | dromaeo_css 18:30:30 INFO - operating with platform_type : linux_ 18:30:30 INFO - Initialising browser for dromaeo_css test... 18:30:31 INFO - TEST-INFO | started process 3281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVU2jz5/profile http://localhost:33262/getInfo.html) 18:30:36 INFO - PROCESS | 3281 | __metrics Screen width/height:1600/1200 18:30:36 INFO - PROCESS | 3281 | colorDepth:24 18:30:36 INFO - PROCESS | 3281 | Browser inner width/height: 1024/697 18:30:36 INFO - PROCESS | 3281 | __metrics 18:30:37 ERROR - PROCESS | 3281 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 18:30:38 INFO - TEST-INFO | 3281: exit 0 18:30:38 INFO - Browser initialized. 18:30:38 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:38 INFO - TEST-INFO | started process 3401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVU2jz5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:50 INFO - PROCESS | 3401 | RSS: Main: 169295872 18:30:50 INFO - PROCESS | 3401 | 18:31:39 INFO - PROCESS | 3401 | 1467768699647 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:33:52 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33262/tests/dromaeo/cssquery-ext.html) 18:33:53 INFO - PROCESS | 3401 | RSS: Main: 171995136 18:33:53 INFO - PROCESS | 3401 | 18:36:55 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-ext.html (next: http://localhost:33262/tests/dromaeo/cssquery-jquery.html) 18:36:56 INFO - PROCESS | 3401 | RSS: Main: 169140224 18:36:56 INFO - PROCESS | 3401 | 18:39:58 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33262/tests/dromaeo/cssquery-mootools.html) 18:39:58 INFO - PROCESS | 3401 | RSS: Main: 172285952 18:39:58 INFO - PROCESS | 3401 | 18:43:00 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33262/tests/dromaeo/cssquery-prototype.html) 18:43:01 INFO - PROCESS | 3401 | RSS: Main: 168460288 18:43:01 INFO - PROCESS | 3401 | 18:46:04 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33262/tests/dromaeo/cssquery-yui.html) 18:46:04 INFO - PROCESS | 3401 | RSS: Main: 170180608 18:46:04 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:33262/tests/dromaeo/cssquery-yui.html (next: http://localhost:33262/tests/dromaeo/cssquery-dojo.html) 18:49:07 INFO - PROCESS | 3401 | RSS: Main: 170766336 18:49:07 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | __start_tp_report 18:49:07 INFO - PROCESS | 3401 | _x_x_mozilla_page_load 18:49:07 INFO - PROCESS | 3401 | _x_x_mozilla_page_load_details 18:49:07 INFO - PROCESS | 3401 | |i|pagename|runs| 18:49:07 INFO - PROCESS | 3401 | |0;dojo.html;2604.8437093774373;2682.24897028832;2683.503551842909;2685.033387980328;2703.5539136042553;4740.431148262209;4778.259369797683;4820.1082799682035;4830.0082193827975;4895.265710143472;4799.7120172789655;4811.831585894494;4818.951810481894;4833.154198015351;4861.270809378595;4401.735895846259;4432.468103827545;4537.047220083787;4545.681802273843;4557.8176872925205;569.9171492915552;4365.759883206422;4432.3573081903105;4442.600165985061;4487.887802804923;4461.464624245079;4477.48508921475;4498.370228168059;4507.414036175276;4519.231730605772;4483.349914262446;4505.954940450586;4508.458984921797;4510.323451482271;4545.5908968193025;4352.998810273623;4382.07976324969;4382.561743825624;4412.227860124465;4443.311286750527;4695.741734204617;4732.83435079774;4770.260609605517;4780.426348838162;4820.590249828769;5127.564157046656;5127.641065125443;5134.435212126663;5139.871503212412;5179.964007198538;5171.5087066728975;5209.2446595243855;5212.983468223698;5213.478652134794;5268.104422248189;4798.592119669797;4802.327674125625;4851.320815085891;4857.295692124622;4893.363862697862;5235.973820130951;5301.787928482818;5314.415414304423;5318.734063296897;5326.946730532645;5148.742562871841;5152;5157.329547158845;5159.845204643867;5192.299039629677;5234.26720259164;5236.73816309183;5256.684598924076;5257.947420525822;5286.36563612369;5033.84898453047;5090.618203634742;5100.5409513143995;5123.257127716534;5180.611454140954;5089.694618322913;5107.106256405188;5121.738480324953;5127.154019586801;5130.230465430215;4323.092150648399;4328.8268469260875;4330.0906809569715;4362.760048197316;4371.584699453547;3712.9628703713156;3733.328000959799;3797.35444974355;3813.0657988792923;3864.9227015459533;4407.713498622579;4427.800748966304;4429.623482004002;4436.800343984529;4502.347159661831;5215.530602245816;5228.660137091153;5229.633925625246;5232.869178270574;5238.240455133984;4375.890602734893;4399.978000109979;4404.273294906305;4404.8458303959205;4423.8451654192595;4564.863054108382;4567.611753001032;4572.9314060289125;4573.817047318136;4574.862754117382;4743.881402964954;4847.903041939212;4849.660523763303;4854.19905715553;4862.610991120631;5061.038402703474;5201.687898725937;5217.556507696889;5238.5023422774775;5320.973395133;4932.876678082933;4933.901321973469;4957.305977163128;4962.379702537183;5005.874853128701;5134.589232861287;5151.150060240018;5152.4847515248175;5156.9428267205885;5161.974190129025;5121.871953201051;5192.792288308426;5236.18839079928;5257.027449921777;5271.947280527299;5039.84880453587;5044.369453818273;5050.888804463012;5052.520010598987;5121.8463446096675;4937.061958227925;5076.593872490118;5092.490750924878;5092.872678183075;5099.311592935054;4932.186189278872;4948.257761335828;4970.676906001098;4987.002599480046;5001.124803159505;4964.156093464192;4978.377702787152;4986.12742770021;4994.001199760135;5031.9245211322595;4872.975635121802;4888.706677599355;4907.803687852446;4922.360093187863;4939.061578300111 18:49:07 INFO - PROCESS | 3401 | |1;ext.html;549.1596264589981;575.5654480866945;583.9970800146;597.2713289786461;618.2735286038903;36476.45285320719;37785;41132.38301425481;41457.378139327935;41543.99999999996;41644.375334369935;42083.368749468704;42250.57749422505;42398.36402453966;42493.57506424935;7856.764297071083;8047.919520804805;8049.235322644339;8054.476459030174;8063.193680631919;7881.448298619099;7979.241972012649;7993.200679932019;8006.479578827387;8016.038075430956;8008.599570021475;8044.718434854782;8046;8050.436469447111;8056.154103819103;7985.1615580363805;8006.519608823489;8019.037715474151;8026;8033.678652853879;7902.3678105751405;7948.761537153895;7964.920350796534;7991.760247192594;7992.3606111510935;39332.60667393318;39469.40795888064;39914.80042599768;40038.19923601512;40051.7997410014;2772.5062270193303;2885;2983.284011837165;3001.6848230935875;3077.938441231163;29884.701152988626;30241.243968900733;30342;30400.54399184014;30904.690953090405;3474.3051389721904;3539.663731945461;3572.8749493767855;3597.3524765542193;3656;250959;251224;251656.74171629208;251919;252894;48534.27198592024;48734.51265487371;48902;48948.75525622349;49001;33034.504482432785;34186.65813341835;34353.656463435545;56904;57012.42987570071;13618.727625447436;13619.387127579283;13621.523246686318;13658.385372658255;13688.794668079987;11582.710432239093;11684.298942063333;11714.589989350332;11719.355435450962;11719.355435451133;18413.81586184148;18471.90764046171;18520.536986575175;18539.35112271091;18588.535286617673;6890.31096890317;6952.687129079203;7065.717371305193;7147.142342918883;7280.41756659466;820.6348175062041;884.893812742475;898.6585097662846;928.2620316848122;998.236349192868;27903.581446278324;28220.294492637437;28439.71560284412;29116.563251551244;29185.97849075272;981.5582987655441;981.906718861707;1000.6197644894893;1011.2011510906301;1080.184460732158;14912.552623421314;15199.544013679608;15330.310136043681;15351;15495;318628;318892;320325;320348;321141;47675;47988;48448.51551484511;48512.757436212596;48592;1160.1067178272851;1191.2137988927266;1207.6920385301692;1210.84864391951;1212.3332167307944;26706.465870682867;27493.45013099767;27511.86244068767;27758.861205693844;28059.859700701367;41772.373414399415;41832.58167418287;41869;42295.7885210572;42313;275765;275924;276553;276816;278509;24469.632955505327;24485.51028979446;24615.38461538476;24974.500509990063;25210.243692689248;41646;42323.365149522164;42580;42848;43055.354169686856;35859.46210806788;36533.08667283339;37631.62368376281;39194.41208381819;39556;37995;38437.80781096077;38770;39090.60909390869;39713.60286397099;36876.446853296686;37091.07272318214;37398.626013740606;37801;38139;33087.669123309424;35141.64858351384;35235.64764352426;35612.64387356093;35674.8216258917;26124;26657.60013599759;26968.73031269662;26999.46001079928;27058.72941270562 18:49:07 INFO - PROCESS | 3401 | |2;jquery.html;372.5454944967139;376.7212262925435;378.50982977044725;385.2314632308545;386.893604258829;16416;16693.16534173291;17631.559211019732;17800.64398712025;17849.910750446244;10421.947890260557;11015.889841101587;11018.944905275463;11036.558537658504;11176.27354221975;4662.997455547057;4706.482286948424;5368.00691872005;5412.2152287918225;5415.702136382497;5182.248573956774;5282.154855223165;5313.840584782443;5318.521333080022;5322;5191.091558977183;5253.684778913277;5291.894162116755;5305.3898801637915;5310.495502927216;5247.107991641411;5302.965921645281;5304.177852432879;5324.440933701944;5343.091674415358;4751.691140075884;4787.329773831666;4790.904181916377;4797.664163508521;4839.298301746262;20469.8976505118;20552.486187845276;21070.262540811;21409.892950535304;21419;1918.012223704793;2152.9677054844033;2345.1791872844537;2345.472268739537;2431;9375;9539.427634341962;9750.853737193947;9811;10642.733931651694;1750.501107184459;1781.688204564209;1804.5037614656076;1806.5935164587993;1810.493061942645;68050;71801.28198718051;73100;75174.62412687956;78385;9809.607615695293;9978.401295922267;10054.447005414773;10303;10491.527881245362;14108.365123569463;14174.503892363924;14194;14231.64420889486;14237.216953067473;7181.8922716159295;7246.166690830517;7287.8542429152185;7382.335589796944;7407.8148046299275;6825.897611535831;6862.9313706863295;6880.8967865482055;6922.965385173042;7000.61496617691;4395.252807022814;4402.361657559636;4440.511543730187;4466.4640243171025;4528.366028755977;1833.669939410919;1835.9265629374943;1845.8061903499938;1853.5273505256343;1856.5080253732772;828.2090603473669;863.2144748279036;938.5635679409107;951.7620594851287;971.0823272007884;17750.822491774918;17908.373206937955;17909.373171938918;18215.362462313755;18322.175502102436;848.7835601921594;857.652650676477;878.6924576398337;894.6063731957918;896.8565029595364;9947.950260248652;9994.950025249827;10037.79924401508;10100.154044797606;10302.690919272434;393256;399934;407572;408747;410793;51343.74328128336;67791.66104169447;78851;89706;91424;939.7979434421633;945.3666043750703;967.1054274795786;986.5511192407438;998.256299057207;16295;16531.83468165303;16567;16785.748213777046;17186.226619801888;28155.57766633461;37568.62431375651;38300.80849595734;39486.605133948295;40332.59667403289;51396.22905656343;56072;56285;56669.71665141648;57403.42596574148;7722.922770772445;7742.109657389247;7860.724874629361;8012.399070069651;8115.594220288844;8270.83458330842;11494.885051149382;12443.25340479538;12557.874421256036;12560.37198140071;10054;10287;10520.053195212467;10624.203184761329;11412.54349826031;10822.188335874998;11007.394593297446;11149.863814291288;11177.66467005991;11251.549938002388;11100.389478578756;11172.441377930909;11317;11350.54597816078;11678.941605291919;7961.323287520626;8067.515949042841;8075.717349892726;8101.351891848756;8147.633356498854;7913.723019694283;10378.636747713794;11069.557217711523;11174.49714762854;11243.887561124284 18:49:07 INFO - PROCESS | 3401 | |3;mootools.html;1373.450619752099;1415.9946438028999;1499.925003749813;1710.5467051231433;1717.1414292853574;6847.212570554388;7600.2779735925;7633.198514156017;8214.466059706116;8243.34053275738;7713.228677132284;7920.405969552277;7964.641591128398;7990.12108668046;8015.31869791067;2150.139944022392;2189.1681161158735;2193.265256139195;2194.3746032380773;2195.736511618608;2154.870707757532;2159.8920053997235;2231.252530402317;2242.551489702058;2242.585121752473;2171.7068195793604;2198.43939795352;2199.2632468123197;2201.856879302848;2235.6311208650554;2140.7324084489437;2157.6763485477145;2160.103557023833;2166.696662467256;2167.8048975592274;2126.33020598511;2151.376100930728;2170.6526955687173;2173.217641649005;2174.0542863854275;7901.1703771103785;7959.761207163794;7969.681212751483;7987.400944929153;8026.157253488358;4611.700239484457;4694.2723877799;4704.694194877322;4720.622350211975;4742.407199100113;2976.1220439970043;2978.1214541710247;3017.2909366298904;3052.771042171846;3087.505999040165;962.6726912849665;967.9467629280387;989.3865803201988;989.6585677941171;994.6419289055934;10784.975427334391;10791.676249712522;10825;10846.891531084746;10879.728006799814;4091.3862920562156;4174.248635245624;4279.037216626234;4311.741295522279;4321.978390108029;9275.90724092764;9304.906950930404;9340.71977840666;9347.719568412958;9349.813003739888;4669.136209801198;4671.602913752301;4675.392199014106;4692.7653617319;4705.929411058837;3652.6529979652423;4129.256733787947;4235.470566179228;4236.597523235288;4272.252355837716;3739.6634302912867;3751.981240093782;3825.9808700956874;3837.654611085016;3940.822662980173;1201.5734414282979;1222.1200735470447;1231.5751065882257;1234.4876876096318;1235.7034311765112;685.715428097334;691.94810389221;699.1784653032768;770.6878714120791;802.8193656427258;4990.9768497457935;5017.071841709296;5049.873753156127;5087.16061849798;5113.258577506241;837.7235512280932;840.4873027453249;878.9824203515894;906.4244204929785;909.3361845852564;3309.420851351004;3320.734341252694;3328.8834890778708;3391.4743214801747;3429.8628054877527;9787.46168960714;10088.293819432716;10215.642452514126;10219.948900255451;10227.079562839232;10113.393196408091;10115.039071288216;10116;10118.645847395306;10124.898751012543;7406.296401841816;7512.21121782216;7517.436192285491;7620.733274335372;7659.387249020177;4900.14247506692;4945.77744001528;4958.082754690394;4998.225275082368;5189;8694.434861733967;8951.104889510996;9019.413738107001;9021.052789457275;9051.818963620823;8733.650653974024;9038.09619038091;9058.139476749699;9091.090890910857;9215.170634642915;5865.648061116347;6714.4292735116105;6724.226713927766;6937.514373993772;6963.61700106499;7622.580758058139;7629.504082234637;7654.693812247448;7692.9615351922885;7725.111612164448;6839.452843772586;7021.262767409348;7052.294770523112;7160.462965277729;7175.641217939186;6805.115335006418;6808.148981377328;6851.417629501549;6976.720931162697;7003.089598352181;6054.3642917493025;6085.178500902499;6087.239095113111;6174.691265436621;6187.566870319034;4373.912521749611;4405.118976204708;4428.2914733642465;4470.396496472935;4529.886752831206;4520.615747661485;4528.275475923836;4532;4575.9771201143785;4610.10103029906 18:49:07 INFO - PROCESS | 3401 | |4;prototype.html;284.31905586121235;285.9328057906392;295.4386665335863;296.8708611753889;301.0801999890334;5133.666311689738;5142.280080788688;5145.073886700397;5164.122099243128;5168.043911876305;5015.448300686921;5032.6477146599755;5041.722705251219;5066.898662026757;5081.8221362252325;3782.527184101987;3868.941965870514;3931.6461518463334;3959.5050618672667;3984.1832424353083;3926.1362500250043;3936.3308237599535;3944.3689009758446;3966.0877998060464;3966.742161759491;3931.272714547818;3935.429362742401;3944.1322908959983;3944.881653550384;3950.4864367632167;3782.167923056923;3888.727789054767;3918.7851765952646;3938.5470670872787;3945.408188771693;3405.9489107663403;3422.982885085559;3424.9657503424896;3434.9141271468166;3448.930831442261;4896.657233993622;4950.183219768734;4959.603231741452;4973.104841128596;5040.941402305521;4396.89007774805;4434.268345722952;4486.663500237462;4495.145922274757;4512.706674066208;5326.573874090063;5329.413764485904;5332.200169974496;5348.117560602496;5419.127862233023;3771.9057023574355;3774.830132644038;3778.6977041836585;3790.223004284115;3801.904952376213;5411.21537377082;5588.86027849303;5604.859878503029;5641.746121424546;5642.548596112301;3799.164183879542;3821.5414150301585;3830.4254361845387;3877.1276462795645;3881.204353107606;3886.1839013806853;3935.4490371348033;3943.2507823514015;3945.500709730284;3951.249262640089;4484.775761211927;4489.910201795946;4507.954920450754;4516.525764794649;4521.434820647419;5244.239585260116;5317.41508434072;5328.946710532922;5337.733113344318;5391.892162156735;1350.743358761832;1355.979660305096;1359.3678939293277;1367.1250399744172;1367.459853357918;838.9538575378291;865.5542395666237;871.7166920750782;875.0724232313768;880.8326417980563;4518.198716795608;4646.326282688991;4651.604613607881;4654.138984287918;4664.836730714409;5505.807296744595;5509.641873278224;5525.419830917776;5534.391216966131;5551.555875529948;4431.955680443154;4674.672772905864;4678.976605116953;4679.719216847;4693.20215563355;2924.5174546199637;2928;2965.620986241408;2972.420378026264;2974.419988102299;5163.380394352626;5234.162533994619;5267.499587539178;5277.445868183862;5282.286891269629;5416.377116631637;5683.346415162227;5683.630564013326;5701.230333904869;5709.800156994485;5241.213817927342;5256.842294731164;5274.235235890851;5288.524032837063;5307.310049693515;5562.11006239016;5584.0227960106;5618.297712785902;5634.549236061187;5648.2092507049865;5167.379914410295;5463.808766693147;5476.808311709071;5477.698726570077;5487.2317875496665;5278.76245568958;5299.7615107321035;5320.494553017457;5328.7602057906715;5336.359636843604;3752.1932784451474;3836.213576216813;3842.193139440749;3843.404272337792;3850.7882066486613;5476.342838859362;5478.808241711521;5506.284183056177;5519.862003449946;5544.500994910316;5340.5994550408095;5340.893182136258;5403.189521571796;5404.351672739852;5420.105682562333;5146.330976972969;5280.1815718563685;5338.8932221356135;5385.488378604026;5389.164679474688;5272.182811664198;5278.234655974786;5296.788128474818;5306.416294207711;5310.522053015247;5140.177571588528;5217.399999000164;5362.3833259174135;5412.864678383072;5424.945750542602;5245.186996015624;5254.343207099113;5266.63133580661;5292.153255479105;5322.509697284767 18:49:07 INFO - PROCESS | 3401 | |5;yui.html;520.0716720653634;547.9589030822686;564.5229780835195;585.3181044083643;597.4921316880651;10998.230123891331;11654.359010254433;11656.067514598823;11691.473883675233;11706;11568.652940411781;11791.410429478514;12016.218945768518;12046.819297710541;12078.939605301961;616.8365383173463;760.9771706848776;767.9155292917789;784.1374488063113;786.3787607789868;778.1673609238118;778.579567033801;779.4504874063772;785.8428314337127;787.5432249295424;820.6266148902265;822.2271065198694;822.2312138150818;823.8393513264916;824.6907409721355;812.8293058457672;814.5112932240638;821.2403526737774;822.116225058062;822.8683410654266;602.7739597650881;603.5262319079502;604.2748701558104;604.6221111805122;605.3522730678176;11806.527738890434;12028.819567706492;12084.456199471046;12094.637160885188;12137.5144994201;13304.933475332658;13518.59444216675;13612.931935340359;13707.931460342734;13793.310334483336;9669.806603867954;9741.951290243504;9751.951240243754;9796.755081122958;9882.505874706236;3184.092533627905;3199.808011519316;3219.227385427504;3250.9837450812593;3264.069740124053;52681;55531.722341388035;55586.44413555894;59559;64337.35662643407;10097.697069087939;10118.797624047478;10192.541335639915;10481.056704896597;10583.100436462833;17790.199441025186;17998.10009499546;18022.3692170776;18043.09784510769;18059.819401806075;6690.13028306317;6749.392554670005;6785.287544807823;6804.183497980175;7000.649967501605;3776.7167462440425;3780.640839120279;3802.3535998880257;3804.4673745675627;3861.227754449121;2645.9867700661757;2729.9181024569293;2755.407587368725;2758.586212068206;2761.1164427383046;493.20593843911274;501.856970763338;502.5527280720162;509.35057801302895;513.3147248423396;490.8769571602761;521.8564894654;551.0466892276385;551.343900758094;557.0863783395235;7427.702891884264;7571.621418929031;7656.349210317186;7688.644143473687;7781.572013539309;601.6901295832649;602.7137109872775;607.5109536822812;622.5890911998059;628.9842753931189;3739.8878033659034;3866.941995870064;3876.244132394156;3951.940720889189;3981.6018398159954;53954.73022634862;54039.72980135074;80847.5957620208;97404;99616;82315;83111.16888831156;84313.57843210867;84392.57803711065;86211.56894215489;74496.25503745001;75661.62169189118;75778;76230.61884690652;76644.23355766482;7898.802529936567;8101.230383113595;8230.876536851832;8241.79395515117;8474.152584741476;45451.54548454473;46020.539794601624;46880.53119468762;47407.52592474169;47514.76242618765;58768.70615646894;66718.33281667122;67071.3292867065;68103.31896681168;69859.30140698528;11309.604163854226;11545.605290283267;11584.710382240512;11819;12099.092568057607;13142.868571314164;13354.666133346744;13673.384697688827;13683.179009259477;13889.791653125008;12542.623721288375;12721.109522333349;12751.17117387404;13111.67220819449;13150.60548183556;12424.751504969669;12704;12882.227066376048;13182;13190.047266565807;11584.47869845842;11914.225575337576;12067.75864482723;12105.757884842078;12218.083643726579;9929.503524823875;9983.951685073253;10037.197024237897;10494.68515944523;10698.251122421356;9773.511324433892;10034.498275086362;10069.546870390703;10081.747956301151;10093.747656308651 18:49:07 INFO - PROCESS | 3401 | __end_tp_report 18:49:07 INFO - PROCESS | 3401 | __start_cc_report 18:49:07 INFO - PROCESS | 3401 | _x_x_mozilla_cycle_collect,385 18:49:07 INFO - PROCESS | 3401 | __end_cc_report 18:49:07 INFO - PROCESS | 3401 | __startTimestamp1467769747897__endTimestamp 18:49:07 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | ------- Summary: start ------- 18:49:07 INFO - PROCESS | 3401 | Number of tests: 6 18:49:07 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | [#0] dojo.html Cycles:165 Average:4753.91 Median:4922.36 stddev:608.98 (12.4%) stddev-sans-first:587.05 18:49:07 INFO - PROCESS | 3401 | Values: 2604.8 2682.2 2683.5 2685.0 2703.6 4740.4 4778.3 4820.1 4830.0 4895.3 4799.7 4811.8 4819.0 4833.2 4861.3 4401.7 4432.5 4537.0 4545.7 4557.8 569.9 4365.8 4432.4 4442.6 4487.9 4461.5 4477.5 4498.4 4507.4 4519.2 4483.3 4506.0 4508.5 4510.3 4545.6 4353.0 4382.1 4382.6 4412.2 4443.3 4695.7 4732.8 4770.3 4780.4 4820.6 5127.6 5127.6 5134.4 5139.9 5180.0 5171.5 5209.2 5213.0 5213.5 5268.1 4798.6 4802.3 4851.3 4857.3 4893.4 5236.0 5301.8 5314.4 5318.7 5326.9 5148.7 5152.0 5157.3 5159.8 5192.3 5234.3 5236.7 5256.7 5257.9 5286.4 5033.8 5090.6 5100.5 5123.3 5180.6 5089.7 5107.1 5121.7 5127.2 5130.2 4323.1 4328.8 4330.1 4362.8 4371.6 3713.0 3733.3 3797.4 3813.1 3864.9 4407.7 4427.8 4429.6 4436.8 4502.3 5215.5 5228.7 5229.6 5232.9 5238.2 4375.9 4400.0 4404.3 4404.8 4423.8 4564.9 4567.6 4572.9 4573.8 4574.9 4743.9 4847.9 4849.7 4854.2 4862.6 5061.0 5201.7 5217.6 5238.5 5321.0 4932.9 4933.9 4957.3 4962.4 5005.9 5134.6 5151.2 5152.5 5156.9 5162.0 5121.9 5192.8 5236.2 5257.0 5271.9 5039.8 5044.4 5050.9 5052.5 5121.8 4937.1 5076.6 5092.5 5092.9 5099.3 4932.2 4948.3 4970.7 4987.0 5001.1 4964.2 4978.4 4986.1 4994.0 5031.9 4873.0 4888.7 4907.8 4922.4 4939.1 18:49:07 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | [#1] ext.html Cycles:180 Average:44385.71 Median:37244.85 stddev:74221.43 (199.3%) stddev-sans-first:74356.66 18:49:07 INFO - PROCESS | 3401 | Values: 549.2 575.6 584.0 597.3 618.3 36476.5 37785.0 41132.4 41457.4 41544.0 41644.4 42083.4 42250.6 42398.4 42493.6 7856.8 8047.9 8049.2 8054.5 8063.2 7881.4 7979.2 7993.2 8006.5 8016.0 8008.6 8044.7 8046.0 8050.4 8056.2 7985.2 8006.5 8019.0 8026.0 8033.7 7902.4 7948.8 7964.9 7991.8 7992.4 39332.6 39469.4 39914.8 40038.2 40051.8 2772.5 2885.0 2983.3 3001.7 3077.9 29884.7 30241.2 30342.0 30400.5 30904.7 3474.3 3539.7 3572.9 3597.4 3656.0 250959.0 251224.0 251656.7 251919.0 252894.0 48534.3 48734.5 48902.0 48948.8 49001.0 33034.5 34186.7 34353.7 56904.0 57012.4 13618.7 13619.4 13621.5 13658.4 13688.8 11582.7 11684.3 11714.6 11719.4 11719.4 18413.8 18471.9 18520.5 18539.4 18588.5 6890.3 6952.7 7065.7 7147.1 7280.4 820.6 884.9 898.7 928.3 998.2 27903.6 28220.3 28439.7 29116.6 29186.0 981.6 981.9 1000.6 1011.2 1080.2 14912.6 15199.5 15330.3 15351.0 15495.0 318628.0 318892.0 320325.0 320348.0 321141.0 47675.0 47988.0 48448.5 48512.8 48592.0 1160.1 1191.2 1207.7 1210.8 1212.3 26706.5 27493.5 27511.9 27758.9 28059.9 41772.4 41832.6 41869.0 42295.8 42313.0 275765.0 275924.0 276553.0 276816.0 278509.0 24469.6 24485.5 24615.4 24974.5 25210.2 41646.0 42323.4 42580.0 42848.0 43055.4 35859.5 36533.1 37631.6 39194.4 39556.0 37995.0 38437.8 38770.0 39090.6 39713.6 36876.4 37091.1 37398.6 37801.0 38139.0 33087.7 35141.6 35235.6 35612.6 35674.8 26124.0 26657.6 26968.7 26999.5 27058.7 18:49:07 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | [#2] jquery.html Cycles:180 Average:24939.31 Median:4398.81 stddev:66790.34 (1518.4%) stddev-sans-first:66952.23 18:49:07 INFO - PROCESS | 3401 | Values: 372.5 376.7 378.5 385.2 386.9 16416.0 16693.2 17631.6 17800.6 17849.9 10421.9 11015.9 11018.9 11036.6 11176.3 4663.0 4706.5 5368.0 5412.2 5415.7 5182.2 5282.2 5313.8 5318.5 5322.0 5191.1 5253.7 5291.9 5305.4 5310.5 5247.1 5303.0 5304.2 5324.4 5343.1 4751.7 4787.3 4790.9 4797.7 4839.3 20469.9 20552.5 21070.3 21409.9 21419.0 1918.0 2153.0 2345.2 2345.5 2431.0 9375.0 9539.4 9750.9 9811.0 10642.7 1750.5 1781.7 1804.5 1806.6 1810.5 68050.0 71801.3 73100.0 75174.6 78385.0 9809.6 9978.4 10054.4 10303.0 10491.5 14108.4 14174.5 14194.0 14231.6 14237.2 7181.9 7246.2 7287.9 7382.3 7407.8 6825.9 6862.9 6880.9 6923.0 7000.6 4395.3 4402.4 4440.5 4466.5 4528.4 1833.7 1835.9 1845.8 1853.5 1856.5 828.2 863.2 938.6 951.8 971.1 17750.8 17908.4 17909.4 18215.4 18322.2 848.8 857.7 878.7 894.6 896.9 9948.0 9995.0 10037.8 10100.2 10302.7 393256.0 399934.0 407572.0 408747.0 410793.0 51343.7 67791.7 78851.0 89706.0 91424.0 939.8 945.4 967.1 986.6 998.3 16295.0 16531.8 16567.0 16785.7 17186.2 28155.6 37568.6 38300.8 39486.6 40332.6 51396.2 56072.0 56285.0 56669.7 57403.4 7722.9 7742.1 7860.7 8012.4 8115.6 8270.8 11494.9 12443.3 12557.9 12560.4 10054.0 10287.0 10520.1 10624.2 11412.5 10822.2 11007.4 11149.9 11177.7 11251.5 11100.4 11172.4 11317.0 11350.5 11678.9 7961.3 8067.5 8075.7 8101.4 8147.6 7913.7 10378.6 11069.6 11174.5 11243.9 18:49:07 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | [#3] mootools.html Cycles:180 Average:5196.60 Median:4705.31 stddev:2958.51 (62.9%) stddev-sans-first:2952.86 18:49:07 INFO - PROCESS | 3401 | Values: 1373.5 1416.0 1499.9 1710.5 1717.1 6847.2 7600.3 7633.2 8214.5 8243.3 7713.2 7920.4 7964.6 7990.1 8015.3 2150.1 2189.2 2193.3 2194.4 2195.7 2154.9 2159.9 2231.3 2242.6 2242.6 2171.7 2198.4 2199.3 2201.9 2235.6 2140.7 2157.7 2160.1 2166.7 2167.8 2126.3 2151.4 2170.7 2173.2 2174.1 7901.2 7959.8 7969.7 7987.4 8026.2 4611.7 4694.3 4704.7 4720.6 4742.4 2976.1 2978.1 3017.3 3052.8 3087.5 962.7 967.9 989.4 989.7 994.6 10785.0 10791.7 10825.0 10846.9 10879.7 4091.4 4174.2 4279.0 4311.7 4322.0 9275.9 9304.9 9340.7 9347.7 9349.8 4669.1 4671.6 4675.4 4692.8 4705.9 3652.7 4129.3 4235.5 4236.6 4272.3 3739.7 3752.0 3826.0 3837.7 3940.8 1201.6 1222.1 1231.6 1234.5 1235.7 685.7 691.9 699.2 770.7 802.8 4991.0 5017.1 5049.9 5087.2 5113.3 837.7 840.5 879.0 906.4 909.3 3309.4 3320.7 3328.9 3391.5 3429.9 9787.5 10088.3 10215.6 10219.9 10227.1 10113.4 10115.0 10116.0 10118.6 10124.9 7406.3 7512.2 7517.4 7620.7 7659.4 4900.1 4945.8 4958.1 4998.2 5189.0 8694.4 8951.1 9019.4 9021.1 9051.8 8733.7 9038.1 9058.1 9091.1 9215.2 5865.6 6714.4 6724.2 6937.5 6963.6 7622.6 7629.5 7654.7 7693.0 7725.1 6839.5 7021.3 7052.3 7160.5 7175.6 6805.1 6808.1 6851.4 6976.7 7003.1 6054.4 6085.2 6087.2 6174.7 6187.6 4373.9 4405.1 4428.3 4470.4 4529.9 4520.6 4528.3 4532.0 4576.0 4610.1 18:49:07 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | [#4] prototype.html Cycles:180 Average:4436.40 Median:5136.92 stddev:1309.81 (25.5%) stddev-sans-first:1275.87 18:49:07 INFO - PROCESS | 3401 | Values: 284.3 285.9 295.4 296.9 301.1 5133.7 5142.3 5145.1 5164.1 5168.0 5015.4 5032.6 5041.7 5066.9 5081.8 3782.5 3868.9 3931.6 3959.5 3984.2 3926.1 3936.3 3944.4 3966.1 3966.7 3931.3 3935.4 3944.1 3944.9 3950.5 3782.2 3888.7 3918.8 3938.5 3945.4 3405.9 3423.0 3425.0 3434.9 3448.9 4896.7 4950.2 4959.6 4973.1 5040.9 4396.9 4434.3 4486.7 4495.1 4512.7 5326.6 5329.4 5332.2 5348.1 5419.1 3771.9 3774.8 3778.7 3790.2 3801.9 5411.2 5588.9 5604.9 5641.7 5642.5 3799.2 3821.5 3830.4 3877.1 3881.2 3886.2 3935.4 3943.3 3945.5 3951.2 4484.8 4489.9 4508.0 4516.5 4521.4 5244.2 5317.4 5328.9 5337.7 5391.9 1350.7 1356.0 1359.4 1367.1 1367.5 839.0 865.6 871.7 875.1 880.8 4518.2 4646.3 4651.6 4654.1 4664.8 5505.8 5509.6 5525.4 5534.4 5551.6 4432.0 4674.7 4679.0 4679.7 4693.2 2924.5 2928.0 2965.6 2972.4 2974.4 5163.4 5234.2 5267.5 5277.4 5282.3 5416.4 5683.3 5683.6 5701.2 5709.8 5241.2 5256.8 5274.2 5288.5 5307.3 5562.1 5584.0 5618.3 5634.5 5648.2 5167.4 5463.8 5476.8 5477.7 5487.2 5278.8 5299.8 5320.5 5328.8 5336.4 3752.2 3836.2 3842.2 3843.4 3850.8 5476.3 5478.8 5506.3 5519.9 5544.5 5340.6 5340.9 5403.2 5404.4 5420.1 5146.3 5280.2 5338.9 5385.5 5389.2 5272.2 5278.2 5296.8 5306.4 5310.5 5140.2 5217.4 5362.4 5412.9 5424.9 5245.2 5254.3 5266.6 5292.2 5322.5 18:49:07 INFO - PROCESS | 3401 | 18:49:07 INFO - PROCESS | 3401 | [#5] yui.html Cycles:180 Average:17217.35 Median:505.95 stddev:24066.05 (4756.6%) stddev-sans-first:24100.90 18:49:07 INFO - PROCESS | 3401 | Values: 520.1 548.0 564.5 585.3 597.5 10998.2 11654.4 11656.1 11691.5 11706.0 11568.7 11791.4 12016.2 12046.8 12078.9 616.8 761.0 767.9 784.1 786.4 778.2 778.6 779.5 785.8 787.5 820.6 822.2 822.2 823.8 824.7 812.8 814.5 821.2 822.1 822.9 602.8 603.5 604.3 604.6 605.4 11806.5 12028.8 12084.5 12094.6 12137.5 13304.9 13518.6 13612.9 13707.9 13793.3 9669.8 9742.0 9752.0 9796.8 9882.5 3184.1 3199.8 3219.2 3251.0 3264.1 52681.0 55531.7 55586.4 59559.0 64337.4 10097.7 10118.8 10192.5 10481.1 10583.1 17790.2 17998.1 18022.4 18043.1 18059.8 6690.1 6749.4 6785.3 6804.2 7000.6 3776.7 3780.6 3802.4 3804.5 3861.2 2646.0 2729.9 2755.4 2758.6 2761.1 493.2 501.9 502.6 509.4 513.3 490.9 521.9 551.0 551.3 557.1 7427.7 7571.6 7656.3 7688.6 7781.6 601.7 602.7 607.5 622.6 629.0 3739.9 3866.9 3876.2 3951.9 3981.6 53954.7 54039.7 80847.6 97404.0 99616.0 82315.0 83111.2 84313.6 84392.6 86211.6 74496.3 75661.6 75778.0 76230.6 76644.2 7898.8 8101.2 8230.9 8241.8 8474.2 45451.5 46020.5 46880.5 47407.5 47514.8 58768.7 66718.3 67071.3 68103.3 69859.3 11309.6 11545.6 11584.7 11819.0 12099.1 13142.9 13354.7 13673.4 13683.2 13889.8 12542.6 12721.1 12751.2 13111.7 13150.6 12424.8 12704.0 12882.2 13182.0 13190.0 11584.5 11914.2 12067.8 12105.8 12218.1 9929.5 9984.0 10037.2 10494.7 10698.3 9773.5 10034.5 10069.5 10081.7 10093.7 18:49:07 INFO - PROCESS | 3401 | -------- Summary: end -------- 18:49:07 INFO - PROCESS | 3401 | 18:49:08 INFO - TEST-INFO | 3401: exit 0 18:49:08 INFO - TEST-OK | dromaeo_css | took 1117650ms 18:49:08 INFO - TEST-START | kraken 18:49:08 INFO - operating with platform_type : linux_ 18:49:08 INFO - Initialising browser for kraken test... 18:49:08 INFO - TEST-INFO | started process 3646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptJieiH/profile http://localhost:33262/getInfo.html) 18:49:13 INFO - PROCESS | 3646 | __metrics Screen width/height:1600/1200 18:49:13 INFO - PROCESS | 3646 | colorDepth:24 18:49:13 INFO - PROCESS | 3646 | Browser inner width/height: 1024/697 18:49:13 INFO - PROCESS | 3646 | __metrics 18:49:13 ERROR - PROCESS | 3646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 18:49:14 INFO - TEST-INFO | 3646: exit 0 18:49:14 INFO - Browser initialized. 18:49:14 INFO - Running cycle 1/1 for kraken test... 18:49:14 INFO - TEST-INFO | started process 3768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptJieiH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:26 INFO - PROCESS | 3768 | RSS: Main: 169791488 18:49:26 INFO - PROCESS | 3768 | 18:49:29 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33262/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:30 INFO - PROCESS | 3768 | RSS: Main: 173694976 18:49:30 INFO - PROCESS | 3768 | 18:49:32 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33262/tests/kraken/driver.html?testName=audio-dft) 18:49:33 INFO - PROCESS | 3768 | RSS: Main: 173776896 18:49:33 INFO - PROCESS | 3768 | 18:49:36 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33262/tests/kraken/driver.html?testName=audio-fft) 18:49:37 INFO - PROCESS | 3768 | RSS: Main: 168775680 18:49:37 INFO - PROCESS | 3768 | 18:49:39 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33262/tests/kraken/driver.html?testName=audio-oscillator) 18:49:39 INFO - PROCESS | 3768 | RSS: Main: 169709568 18:49:39 INFO - PROCESS | 3768 | 18:49:42 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:42 INFO - PROCESS | 3768 | RSS: Main: 170033152 18:49:42 INFO - PROCESS | 3768 | 18:49:45 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33262/tests/kraken/driver.html?testName=imaging-darkroom) 18:49:46 INFO - PROCESS | 3768 | RSS: Main: 170352640 18:49:46 INFO - PROCESS | 3768 | 18:49:50 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33262/tests/kraken/driver.html?testName=imaging-desaturate) 18:49:50 INFO - PROCESS | 3768 | RSS: Main: 168226816 18:49:50 INFO - PROCESS | 3768 | 18:49:53 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33262/tests/kraken/driver.html?testName=json-parse-financial) 18:49:54 INFO - PROCESS | 3768 | RSS: Main: 169332736 18:49:54 INFO - PROCESS | 3768 | 18:49:56 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:49:56 INFO - PROCESS | 3768 | RSS: Main: 170070016 18:49:56 INFO - PROCESS | 3768 | 18:49:58 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:49:59 INFO - PROCESS | 3768 | RSS: Main: 169943040 18:49:59 INFO - PROCESS | 3768 | 18:50:01 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:50:02 INFO - PROCESS | 3768 | RSS: Main: 170692608 18:50:02 INFO - PROCESS | 3768 | 18:50:04 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:05 INFO - PROCESS | 3768 | RSS: Main: 170979328 18:50:05 INFO - PROCESS | 3768 | 18:50:08 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:09 INFO - PROCESS | 3768 | RSS: Main: 170323968 18:50:09 INFO - PROCESS | 3768 | 18:50:10 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33262/tests/kraken/driver.html?testName=ai-astar) 18:50:11 INFO - PROCESS | 3768 | RSS: Main: 171499520 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | __start_tp_report 18:50:11 INFO - PROCESS | 3768 | _x_x_mozilla_page_load 18:50:11 INFO - PROCESS | 3768 | _x_x_mozilla_page_load_details 18:50:11 INFO - PROCESS | 3768 | |i|pagename|runs| 18:50:11 INFO - PROCESS | 3768 | |0;ai-astar;103;115;108;113;112;115;115;113;113;112 18:50:11 INFO - PROCESS | 3768 | |1;audio-beat-detection;150;125;151;182;123;155;143;126;188;127 18:50:11 INFO - PROCESS | 3768 | |2;audio-dft;163;162;164;168;167;162;163;162;162;162 18:50:11 INFO - PROCESS | 3768 | |3;audio-fft;75;77;76;157;78;74;75;76;161;77 18:50:11 INFO - PROCESS | 3768 | |4;audio-oscillator;86;85;145;86;87;85;140;86;86;130 18:50:11 INFO - PROCESS | 3768 | |5;imaging-gaussian-blur;118;117;118;117;118;117;118;118;118;118 18:50:11 INFO - PROCESS | 3768 | |6;imaging-darkroom;148;149;147;147;148;148;148;148;150;148 18:50:11 INFO - PROCESS | 3768 | |7;imaging-desaturate;95;96;96;95;95;96;96;95;95;95 18:50:11 INFO - PROCESS | 3768 | |8;json-parse-financial;63;63;65;64;66;64;64;65;65;64 18:50:11 INFO - PROCESS | 3768 | |9;json-stringify-tinderbox;65;64;65;64;65;64;64;63;68;64 18:50:11 INFO - PROCESS | 3768 | |10;stanford-crypto-aes;80;79;81;78;84;83;87;78;84;78 18:50:11 INFO - PROCESS | 3768 | |11;stanford-crypto-ccm;142;139;142;131;132;140;139;140;171;131 18:50:11 INFO - PROCESS | 3768 | |12;stanford-crypto-pbkdf2;168;164;164;167;170;165;163;166;170;172 18:50:11 INFO - PROCESS | 3768 | |13;stanford-crypto-sha256-iterative;68;67;68;72;67;65;66;68;67;69 18:50:11 INFO - PROCESS | 3768 | __end_tp_report 18:50:11 INFO - PROCESS | 3768 | __start_cc_report 18:50:11 INFO - PROCESS | 3768 | _x_x_mozilla_cycle_collect,988 18:50:11 INFO - PROCESS | 3768 | __end_cc_report 18:50:11 INFO - PROCESS | 3768 | __startTimestamp1467769811017__endTimestamp 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | ------- Summary: start ------- 18:50:11 INFO - PROCESS | 3768 | Number of tests: 14 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:2.20 18:50:11 INFO - PROCESS | 3768 | Values: 103.0 115.0 108.0 113.0 112.0 115.0 115.0 113.0 113.0 112.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:150.50 stddev:23.36 (15.5%) stddev-sans-first:24.75 18:50:11 INFO - PROCESS | 3768 | Values: 150.0 125.0 151.0 182.0 123.0 155.0 143.0 126.0 188.0 127.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.22 (1.4%) stddev-sans-first:2.35 18:50:11 INFO - PROCESS | 3768 | Values: 163.0 162.0 164.0 168.0 167.0 162.0 163.0 162.0 162.0 162.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:35.03 (46.1%) stddev-sans-first:36.57 18:50:11 INFO - PROCESS | 3768 | Values: 75.0 77.0 76.0 157.0 78.0 74.0 75.0 76.0 161.0 77.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:86.00 stddev:25.61 (29.8%) stddev-sans-first:26.53 18:50:11 INFO - PROCESS | 3768 | Values: 86.0 85.0 145.0 86.0 87.0 85.0 140.0 86.0 86.0 130.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:50:11 INFO - PROCESS | 3768 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 18:50:11 INFO - PROCESS | 3768 | Values: 148.0 149.0 147.0 147.0 148.0 148.0 148.0 148.0 150.0 148.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:50:11 INFO - PROCESS | 3768 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.88 18:50:11 INFO - PROCESS | 3768 | Values: 63.0 63.0 65.0 64.0 66.0 64.0 64.0 65.0 65.0 64.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.50 stddev:1.35 (2.1%) stddev-sans-first:1.42 18:50:11 INFO - PROCESS | 3768 | Values: 65.0 64.0 65.0 64.0 65.0 64.0 64.0 63.0 68.0 64.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:82.00 stddev:3.16 (3.8%) stddev-sans-first:3.32 18:50:11 INFO - PROCESS | 3768 | Values: 80.0 79.0 81.0 78.0 84.0 83.0 87.0 78.0 84.0 78.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:140.00 stddev:11.51 (8.2%) stddev-sans-first:12.20 18:50:11 INFO - PROCESS | 3768 | Values: 142.0 139.0 142.0 131.0 132.0 140.0 139.0 140.0 171.0 131.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:167.50 stddev:3.03 (1.8%) stddev-sans-first:3.19 18:50:11 INFO - PROCESS | 3768 | Values: 168.0 164.0 164.0 167.0 170.0 165.0 163.0 166.0 170.0 172.0 18:50:11 INFO - PROCESS | 3768 | 18:50:11 INFO - PROCESS | 3768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:2.00 18:50:11 INFO - PROCESS | 3768 | Values: 68.0 67.0 68.0 72.0 67.0 65.0 66.0 68.0 67.0 69.0 18:50:11 INFO - PROCESS | 3768 | -------- Summary: end -------- 18:50:11 INFO - PROCESS | 3768 | 18:50:12 INFO - TEST-INFO | 3768: exit 0 18:50:12 INFO - TEST-OK | kraken | took 63417ms 18:50:12 INFO - SUITE-END | took 1181s 18:50:12 INFO - Completed test suite (00:19:41) 18:50:12 INFO - javascript benchmark 18:50:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6481.631928378968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.8437093774373, 2682.24897028832, 2683.503551842909, 2685.033387980328, 2703.5539136042553, 4740.431148262209, 4778.259369797683, 4820.1082799682035, 4830.0082193827975, 4895.265710143472, 4799.7120172789655, 4811.831585894494, 4818.951810481894, 4833.154198015351, 4861.270809378595, 4401.735895846259, 4432.468103827545, 4537.047220083787, 4545.681802273843, 4557.8176872925205, 569.9171492915552, 4365.759883206422, 4432.3573081903105, 4442.600165985061, 4487.887802804923, 4461.464624245079, 4477.48508921475, 4498.370228168059, 4507.414036175276, 4519.231730605772, 4483.349914262446, 4505.954940450586, 4508.458984921797, 4510.323451482271, 4545.5908968193025, 4352.998810273623, 4382.07976324969, 4382.561743825624, 4412.227860124465, 4443.311286750527, 4695.741734204617, 4732.83435079774, 4770.260609605517, 4780.426348838162, 4820.590249828769, 5127.564157046656, 5127.641065125443, 5134.435212126663, 5139.871503212412, 5179.964007198538, 5171.5087066728975, 5209.2446595243855, 5212.983468223698, 5213.478652134794, 5268.104422248189, 4798.592119669797, 4802.327674125625, 4851.320815085891, 4857.295692124622, 4893.363862697862, 5235.973820130951, 5301.787928482818, 5314.415414304423, 5318.734063296897, 5326.946730532645, 5148.742562871841, 5152.0, 5157.329547158845, 5159.845204643867, 5192.299039629677, 5234.26720259164, 5236.73816309183, 5256.684598924076, 5257.947420525822, 5286.36563612369, 5033.84898453047, 5090.618203634742, 5100.5409513143995, 5123.257127716534, 5180.611454140954, 5089.694618322913, 5107.106256405188, 5121.738480324953, 5127.154019586801, 5130.230465430215, 4323.092150648399, 4328.8268469260875, 4330.0906809569715, 4362.760048197316, 4371.584699453547, 3712.9628703713156, 3733.328000959799, 3797.35444974355, 3813.0657988792923, 3864.9227015459533, 4407.713498622579, 4427.800748966304, 4429.623482004002, 4436.800343984529, 4502.347159661831, 5215.530602245816, 5228.660137091153, 5229.633925625246, 5232.869178270574, 5238.240455133984, 4375.890602734893, 4399.978000109979, 4404.273294906305, 4404.8458303959205, 4423.8451654192595, 4564.863054108382, 4567.611753001032, 4572.9314060289125, 4573.817047318136, 4574.862754117382, 4743.881402964954, 4847.903041939212, 4849.660523763303, 4854.19905715553, 4862.610991120631, 5061.038402703474, 5201.687898725937, 5217.556507696889, 5238.5023422774775, 5320.973395133, 4932.876678082933, 4933.901321973469, 4957.305977163128, 4962.379702537183, 5005.874853128701, 5134.589232861287, 5151.150060240018, 5152.4847515248175, 5156.9428267205885, 5161.974190129025, 5121.871953201051, 5192.792288308426, 5236.18839079928, 5257.027449921777, 5271.947280527299, 5039.84880453587, 5044.369453818273, 5050.888804463012, 5052.520010598987, 5121.8463446096675, 4937.061958227925, 5076.593872490118, 5092.490750924878, 5092.872678183075, 5099.311592935054, 4932.186189278872, 4948.257761335828, 4970.676906001098, 4987.002599480046, 5001.124803159505, 4964.156093464192, 4978.377702787152, 4986.12742770021, 4994.001199760135, 5031.9245211322595, 4872.975635121802, 4888.706677599355, 4907.803687852446, 4922.360093187863, 4939.061578300111], "value": 4716.086060057448, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.1596264589981, 575.5654480866945, 583.9970800146, 597.2713289786461, 618.2735286038903, 36476.45285320719, 37785.0, 41132.38301425481, 41457.378139327935, 41543.99999999996, 41644.375334369935, 42083.368749468704, 42250.57749422505, 42398.36402453966, 42493.57506424935, 7856.764297071083, 8047.919520804805, 8049.235322644339, 8054.476459030174, 8063.193680631919, 7881.448298619099, 7979.241972012649, 7993.200679932019, 8006.479578827387, 8016.038075430956, 8008.599570021475, 8044.718434854782, 8046.0, 8050.436469447111, 8056.154103819103, 7985.1615580363805, 8006.519608823489, 8019.037715474151, 8026.0, 8033.678652853879, 7902.3678105751405, 7948.761537153895, 7964.920350796534, 7991.760247192594, 7992.3606111510935, 39332.60667393318, 39469.40795888064, 39914.80042599768, 40038.19923601512, 40051.7997410014, 2772.5062270193303, 2885.0, 2983.284011837165, 3001.6848230935875, 3077.938441231163, 29884.701152988626, 30241.243968900733, 30342.0, 30400.54399184014, 30904.690953090405, 3474.3051389721904, 3539.663731945461, 3572.8749493767855, 3597.3524765542193, 3656.0, 250959.0, 251224.0, 251656.74171629208, 251919.0, 252894.0, 48534.27198592024, 48734.51265487371, 48902.0, 48948.75525622349, 49001.0, 33034.504482432785, 34186.65813341835, 34353.656463435545, 56904.0, 57012.42987570071, 13618.727625447436, 13619.387127579283, 13621.523246686318, 13658.385372658255, 13688.794668079987, 11582.710432239093, 11684.298942063333, 11714.589989350332, 11719.355435450962, 11719.355435451133, 18413.81586184148, 18471.90764046171, 18520.536986575175, 18539.35112271091, 18588.535286617673, 6890.31096890317, 6952.687129079203, 7065.717371305193, 7147.142342918883, 7280.41756659466, 820.6348175062041, 884.893812742475, 898.6585097662846, 928.2620316848122, 998.236349192868, 27903.581446278324, 28220.294492637437, 28439.71560284412, 29116.563251551244, 29185.97849075272, 981.5582987655441, 981.906718861707, 1000.6197644894893, 1011.2011510906301, 1080.184460732158, 14912.552623421314, 15199.544013679608, 15330.310136043681, 15351.0, 15495.0, 318628.0, 318892.0, 320325.0, 320348.0, 321141.0, 47675.0, 47988.0, 48448.51551484511, 48512.757436212596, 48592.0, 1160.1067178272851, 1191.2137988927266, 1207.6920385301692, 1210.84864391951, 1212.3332167307944, 26706.465870682867, 27493.45013099767, 27511.86244068767, 27758.861205693844, 28059.859700701367, 41772.373414399415, 41832.58167418287, 41869.0, 42295.7885210572, 42313.0, 275765.0, 275924.0, 276553.0, 276816.0, 278509.0, 24469.632955505327, 24485.51028979446, 24615.38461538476, 24974.500509990063, 25210.243692689248, 41646.0, 42323.365149522164, 42580.0, 42848.0, 43055.354169686856, 35859.46210806788, 36533.08667283339, 37631.62368376281, 39194.41208381819, 39556.0, 37995.0, 38437.80781096077, 38770.0, 39090.60909390869, 39713.60286397099, 36876.446853296686, 37091.07272318214, 37398.626013740606, 37801.0, 38139.0, 33087.669123309424, 35141.64858351384, 35235.64764352426, 35612.64387356093, 35674.8216258917, 26124.0, 26657.60013599759, 26968.73031269662, 26999.46001079928, 27058.72941270562], "value": 17511.235430147484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.5454944967139, 376.7212262925435, 378.50982977044725, 385.2314632308545, 386.893604258829, 16416.0, 16693.16534173291, 17631.559211019732, 17800.64398712025, 17849.910750446244, 10421.947890260557, 11015.889841101587, 11018.944905275463, 11036.558537658504, 11176.27354221975, 4662.997455547057, 4706.482286948424, 5368.00691872005, 5412.2152287918225, 5415.702136382497, 5182.248573956774, 5282.154855223165, 5313.840584782443, 5318.521333080022, 5322.0, 5191.091558977183, 5253.684778913277, 5291.894162116755, 5305.3898801637915, 5310.495502927216, 5247.107991641411, 5302.965921645281, 5304.177852432879, 5324.440933701944, 5343.091674415358, 4751.691140075884, 4787.329773831666, 4790.904181916377, 4797.664163508521, 4839.298301746262, 20469.8976505118, 20552.486187845276, 21070.262540811, 21409.892950535304, 21419.0, 1918.012223704793, 2152.9677054844033, 2345.1791872844537, 2345.472268739537, 2431.0, 9375.0, 9539.427634341962, 9750.853737193947, 9811.0, 10642.733931651694, 1750.501107184459, 1781.688204564209, 1804.5037614656076, 1806.5935164587993, 1810.493061942645, 68050.0, 71801.28198718051, 73100.0, 75174.62412687956, 78385.0, 9809.607615695293, 9978.401295922267, 10054.447005414773, 10303.0, 10491.527881245362, 14108.365123569463, 14174.503892363924, 14194.0, 14231.64420889486, 14237.216953067473, 7181.8922716159295, 7246.166690830517, 7287.8542429152185, 7382.335589796944, 7407.8148046299275, 6825.897611535831, 6862.9313706863295, 6880.8967865482055, 6922.965385173042, 7000.61496617691, 4395.252807022814, 4402.361657559636, 4440.511543730187, 4466.4640243171025, 4528.366028755977, 1833.669939410919, 1835.9265629374943, 1845.8061903499938, 1853.5273505256343, 1856.5080253732772, 828.2090603473669, 863.2144748279036, 938.5635679409107, 951.7620594851287, 971.0823272007884, 17750.822491774918, 17908.373206937955, 17909.373171938918, 18215.362462313755, 18322.175502102436, 848.7835601921594, 857.652650676477, 878.6924576398337, 894.6063731957918, 896.8565029595364, 9947.950260248652, 9994.950025249827, 10037.79924401508, 10100.154044797606, 10302.690919272434, 393256.0, 399934.0, 407572.0, 408747.0, 410793.0, 51343.74328128336, 67791.66104169447, 78851.0, 89706.0, 91424.0, 939.7979434421633, 945.3666043750703, 967.1054274795786, 986.5511192407438, 998.256299057207, 16295.0, 16531.83468165303, 16567.0, 16785.748213777046, 17186.226619801888, 28155.57766633461, 37568.62431375651, 38300.80849595734, 39486.605133948295, 40332.59667403289, 51396.22905656343, 56072.0, 56285.0, 56669.71665141648, 57403.42596574148, 7722.922770772445, 7742.109657389247, 7860.724874629361, 8012.399070069651, 8115.594220288844, 8270.83458330842, 11494.885051149382, 12443.25340479538, 12557.874421256036, 12560.37198140071, 10054.0, 10287.0, 10520.053195212467, 10624.203184761329, 11412.54349826031, 10822.188335874998, 11007.394593297446, 11149.863814291288, 11177.66467005991, 11251.549938002388, 11100.389478578756, 11172.441377930909, 11317.0, 11350.54597816078, 11678.941605291919, 7961.323287520626, 8067.515949042841, 8075.717349892726, 8101.351891848756, 8147.633356498854, 7913.723019694283, 10378.636747713794, 11069.557217711523, 11174.49714762854, 11243.887561124284], "value": 8328.178887925831, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.450619752099, 1415.9946438028999, 1499.925003749813, 1710.5467051231433, 1717.1414292853574, 6847.212570554388, 7600.2779735925, 7633.198514156017, 8214.466059706116, 8243.34053275738, 7713.228677132284, 7920.405969552277, 7964.641591128398, 7990.12108668046, 8015.31869791067, 2150.139944022392, 2189.1681161158735, 2193.265256139195, 2194.3746032380773, 2195.736511618608, 2154.870707757532, 2159.8920053997235, 2231.252530402317, 2242.551489702058, 2242.585121752473, 2171.7068195793604, 2198.43939795352, 2199.2632468123197, 2201.856879302848, 2235.6311208650554, 2140.7324084489437, 2157.6763485477145, 2160.103557023833, 2166.696662467256, 2167.8048975592274, 2126.33020598511, 2151.376100930728, 2170.6526955687173, 2173.217641649005, 2174.0542863854275, 7901.1703771103785, 7959.761207163794, 7969.681212751483, 7987.400944929153, 8026.157253488358, 4611.700239484457, 4694.2723877799, 4704.694194877322, 4720.622350211975, 4742.407199100113, 2976.1220439970043, 2978.1214541710247, 3017.2909366298904, 3052.771042171846, 3087.505999040165, 962.6726912849665, 967.9467629280387, 989.3865803201988, 989.6585677941171, 994.6419289055934, 10784.975427334391, 10791.676249712522, 10825.0, 10846.891531084746, 10879.728006799814, 4091.3862920562156, 4174.248635245624, 4279.037216626234, 4311.741295522279, 4321.978390108029, 9275.90724092764, 9304.906950930404, 9340.71977840666, 9347.719568412958, 9349.813003739888, 4669.136209801198, 4671.602913752301, 4675.392199014106, 4692.7653617319, 4705.929411058837, 3652.6529979652423, 4129.256733787947, 4235.470566179228, 4236.597523235288, 4272.252355837716, 3739.6634302912867, 3751.981240093782, 3825.9808700956874, 3837.654611085016, 3940.822662980173, 1201.5734414282979, 1222.1200735470447, 1231.5751065882257, 1234.4876876096318, 1235.7034311765112, 685.715428097334, 691.94810389221, 699.1784653032768, 770.6878714120791, 802.8193656427258, 4990.9768497457935, 5017.071841709296, 5049.873753156127, 5087.16061849798, 5113.258577506241, 837.7235512280932, 840.4873027453249, 878.9824203515894, 906.4244204929785, 909.3361845852564, 3309.420851351004, 3320.734341252694, 3328.8834890778708, 3391.4743214801747, 3429.8628054877527, 9787.46168960714, 10088.293819432716, 10215.642452514126, 10219.948900255451, 10227.079562839232, 10113.393196408091, 10115.039071288216, 10116.0, 10118.645847395306, 10124.898751012543, 7406.296401841816, 7512.21121782216, 7517.436192285491, 7620.733274335372, 7659.387249020177, 4900.14247506692, 4945.77744001528, 4958.082754690394, 4998.225275082368, 5189.0, 8694.434861733967, 8951.104889510996, 9019.413738107001, 9021.052789457275, 9051.818963620823, 8733.650653974024, 9038.09619038091, 9058.139476749699, 9091.090890910857, 9215.170634642915, 5865.648061116347, 6714.4292735116105, 6724.226713927766, 6937.514373993772, 6963.61700106499, 7622.580758058139, 7629.504082234637, 7654.693812247448, 7692.9615351922885, 7725.111612164448, 6839.452843772586, 7021.262767409348, 7052.294770523112, 7160.462965277729, 7175.641217939186, 6805.115335006418, 6808.148981377328, 6851.417629501549, 6976.720931162697, 7003.089598352181, 6054.3642917493025, 6085.178500902499, 6087.239095113111, 6174.691265436621, 6187.566870319034, 4373.912521749611, 4405.118976204708, 4428.2914733642465, 4470.396496472935, 4529.886752831206, 4520.615747661485, 4528.275475923836, 4532.0, 4575.9771201143785, 4610.10103029906], "value": 4166.819897632179, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.31905586121235, 285.9328057906392, 295.4386665335863, 296.8708611753889, 301.0801999890334, 5133.666311689738, 5142.280080788688, 5145.073886700397, 5164.122099243128, 5168.043911876305, 5015.448300686921, 5032.6477146599755, 5041.722705251219, 5066.898662026757, 5081.8221362252325, 3782.527184101987, 3868.941965870514, 3931.6461518463334, 3959.5050618672667, 3984.1832424353083, 3926.1362500250043, 3936.3308237599535, 3944.3689009758446, 3966.0877998060464, 3966.742161759491, 3931.272714547818, 3935.429362742401, 3944.1322908959983, 3944.881653550384, 3950.4864367632167, 3782.167923056923, 3888.727789054767, 3918.7851765952646, 3938.5470670872787, 3945.408188771693, 3405.9489107663403, 3422.982885085559, 3424.9657503424896, 3434.9141271468166, 3448.930831442261, 4896.657233993622, 4950.183219768734, 4959.603231741452, 4973.104841128596, 5040.941402305521, 4396.89007774805, 4434.268345722952, 4486.663500237462, 4495.145922274757, 4512.706674066208, 5326.573874090063, 5329.413764485904, 5332.200169974496, 5348.117560602496, 5419.127862233023, 3771.9057023574355, 3774.830132644038, 3778.6977041836585, 3790.223004284115, 3801.904952376213, 5411.21537377082, 5588.86027849303, 5604.859878503029, 5641.746121424546, 5642.548596112301, 3799.164183879542, 3821.5414150301585, 3830.4254361845387, 3877.1276462795645, 3881.204353107606, 3886.1839013806853, 3935.4490371348033, 3943.2507823514015, 3945.500709730284, 3951.249262640089, 4484.775761211927, 4489.910201795946, 4507.954920450754, 4516.525764794649, 4521.434820647419, 5244.239585260116, 5317.41508434072, 5328.946710532922, 5337.733113344318, 5391.892162156735, 1350.743358761832, 1355.979660305096, 1359.3678939293277, 1367.1250399744172, 1367.459853357918, 838.9538575378291, 865.5542395666237, 871.7166920750782, 875.0724232313768, 880.8326417980563, 4518.198716795608, 4646.326282688991, 4651.604613607881, 4654.138984287918, 4664.836730714409, 5505.807296744595, 5509.641873278224, 5525.419830917776, 5534.391216966131, 5551.555875529948, 4431.955680443154, 4674.672772905864, 4678.976605116953, 4679.719216847, 4693.20215563355, 2924.5174546199637, 2928.0, 2965.620986241408, 2972.420378026264, 2974.419988102299, 5163.380394352626, 5234.162533994619, 5267.499587539178, 5277.445868183862, 5282.286891269629, 5416.377116631637, 5683.346415162227, 5683.630564013326, 5701.230333904869, 5709.800156994485, 5241.213817927342, 5256.842294731164, 5274.235235890851, 5288.524032837063, 5307.310049693515, 5562.11006239016, 5584.0227960106, 5618.297712785902, 5634.549236061187, 5648.2092507049865, 5167.379914410295, 5463.808766693147, 5476.808311709071, 5477.698726570077, 5487.2317875496665, 5278.76245568958, 5299.7615107321035, 5320.494553017457, 5328.7602057906715, 5336.359636843604, 3752.1932784451474, 3836.213576216813, 3842.193139440749, 3843.404272337792, 3850.7882066486613, 5476.342838859362, 5478.808241711521, 5506.284183056177, 5519.862003449946, 5544.500994910316, 5340.5994550408095, 5340.893182136258, 5403.189521571796, 5404.351672739852, 5420.105682562333, 5146.330976972969, 5280.1815718563685, 5338.8932221356135, 5385.488378604026, 5389.164679474688, 5272.182811664198, 5278.234655974786, 5296.788128474818, 5306.416294207711, 5310.522053015247, 5140.177571588528, 5217.399999000164, 5362.3833259174135, 5412.864678383072, 5424.945750542602, 5245.186996015624, 5254.343207099113, 5266.63133580661, 5292.153255479105, 5322.509697284767], "value": 4010.6902258554774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.0716720653634, 547.9589030822686, 564.5229780835195, 585.3181044083643, 597.4921316880651, 10998.230123891331, 11654.359010254433, 11656.067514598823, 11691.473883675233, 11706.0, 11568.652940411781, 11791.410429478514, 12016.218945768518, 12046.819297710541, 12078.939605301961, 616.8365383173463, 760.9771706848776, 767.9155292917789, 784.1374488063113, 786.3787607789868, 778.1673609238118, 778.579567033801, 779.4504874063772, 785.8428314337127, 787.5432249295424, 820.6266148902265, 822.2271065198694, 822.2312138150818, 823.8393513264916, 824.6907409721355, 812.8293058457672, 814.5112932240638, 821.2403526737774, 822.116225058062, 822.8683410654266, 602.7739597650881, 603.5262319079502, 604.2748701558104, 604.6221111805122, 605.3522730678176, 11806.527738890434, 12028.819567706492, 12084.456199471046, 12094.637160885188, 12137.5144994201, 13304.933475332658, 13518.59444216675, 13612.931935340359, 13707.931460342734, 13793.310334483336, 9669.806603867954, 9741.951290243504, 9751.951240243754, 9796.755081122958, 9882.505874706236, 3184.092533627905, 3199.808011519316, 3219.227385427504, 3250.9837450812593, 3264.069740124053, 52681.0, 55531.722341388035, 55586.44413555894, 59559.0, 64337.35662643407, 10097.697069087939, 10118.797624047478, 10192.541335639915, 10481.056704896597, 10583.100436462833, 17790.199441025186, 17998.10009499546, 18022.3692170776, 18043.09784510769, 18059.819401806075, 6690.13028306317, 6749.392554670005, 6785.287544807823, 6804.183497980175, 7000.649967501605, 3776.7167462440425, 3780.640839120279, 3802.3535998880257, 3804.4673745675627, 3861.227754449121, 2645.9867700661757, 2729.9181024569293, 2755.407587368725, 2758.586212068206, 2761.1164427383046, 493.20593843911274, 501.856970763338, 502.5527280720162, 509.35057801302895, 513.3147248423396, 490.8769571602761, 521.8564894654, 551.0466892276385, 551.343900758094, 557.0863783395235, 7427.702891884264, 7571.621418929031, 7656.349210317186, 7688.644143473687, 7781.572013539309, 601.6901295832649, 602.7137109872775, 607.5109536822812, 622.5890911998059, 628.9842753931189, 3739.8878033659034, 3866.941995870064, 3876.244132394156, 3951.940720889189, 3981.6018398159954, 53954.73022634862, 54039.72980135074, 80847.5957620208, 97404.0, 99616.0, 82315.0, 83111.16888831156, 84313.57843210867, 84392.57803711065, 86211.56894215489, 74496.25503745001, 75661.62169189118, 75778.0, 76230.61884690652, 76644.23355766482, 7898.802529936567, 8101.230383113595, 8230.876536851832, 8241.79395515117, 8474.152584741476, 45451.54548454473, 46020.539794601624, 46880.53119468762, 47407.52592474169, 47514.76242618765, 58768.70615646894, 66718.33281667122, 67071.3292867065, 68103.31896681168, 69859.30140698528, 11309.604163854226, 11545.605290283267, 11584.710382240512, 11819.0, 12099.092568057607, 13142.868571314164, 13354.666133346744, 13673.384697688827, 13683.179009259477, 13889.791653125008, 12542.623721288375, 12721.109522333349, 12751.17117387404, 13111.67220819449, 13150.60548183556, 12424.751504969669, 12704.0, 12882.227066376048, 13182.0, 13190.047266565807, 11584.47869845842, 11914.225575337576, 12067.75864482723, 12105.757884842078, 12218.083643726579, 9929.503524823875, 9983.951685073253, 10037.197024237897, 10494.68515944523, 10698.251122421356, 9773.511324433892, 10034.498275086362, 10069.546870390703, 10081.747956301151, 10093.747656308651], "value": 6450.404498724924, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 108.0, 113.0, 112.0, 115.0, 115.0, 113.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 151.0, 182.0, 123.0, 155.0, 143.0, 126.0, 188.0, 127.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 168.0, 167.0, 162.0, 163.0, 162.0, 162.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 157.0, 78.0, 74.0, 75.0, 76.0, 161.0, 77.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 145.0, 86.0, 87.0, 85.0, 140.0, 86.0, 86.0, 130.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 150.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 64.0, 66.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 63.0, 68.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 78.0, 84.0, 83.0, 87.0, 78.0, 84.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 142.0, 131.0, 132.0, 140.0, 139.0, 140.0, 171.0, 131.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 164.0, 167.0, 170.0, 165.0, 163.0, 166.0, 170.0, 172.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 72.0, 67.0, 65.0, 66.0, 68.0, 67.0, 69.0], "value": 67.7, "unit": "score"}]}]} 18:50:12 INFO - Return code: 0 18:50:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:50:12 ERROR - # TBPL SUCCESS # 18:50:12 INFO - Running post-action listener: _resource_record_post_action 18:50:12 INFO - ##### 18:50:12 INFO - ##### Finished run-tests step (success) 18:50:12 INFO - ##### 18:50:12 INFO - Running post-run listener: _resource_record_post_run 18:50:12 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7872512; Write bytes: 397701120; Read time: 1244; Write time: 286316 18:50:12 INFO - TinderboxPrint: CPU usage
13.3% 18:50:12 INFO - TinderboxPrint: I/O read bytes / time
7,872,512 / 1,244 18:50:12 INFO - TinderboxPrint: I/O write bytes / time
397,701,120 / 286,316 18:50:12 INFO - TinderboxPrint: CPU idle
8,289.1 (86.7%) 18:50:12 INFO - TinderboxPrint: CPU user
1,218.2 (12.7%) 18:50:12 INFO - TinderboxPrint: Swap in / out
0 / 0 18:50:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 49635328; Read time: 0; Write time: 16636 18:50:12 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 5636096; Write bytes: 305369088; Read time: 1072; Write time: 225940 18:50:12 INFO - Running post-run listener: _upload_blobber_files 18:50:12 INFO - Blob upload gear active. 18:50:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:12 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 18:50:12 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:50:12 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:50:13 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:50:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:50:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:14 INFO - (blobuploader) - INFO - Done attempting. 18:50:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:50:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:17 INFO - (blobuploader) - INFO - Done attempting. 18:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:18 INFO - (blobuploader) - INFO - Done attempting. 18:50:18 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:18 INFO - Return code: 0 18:50:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a30bb68cf16050b76067b9573e6e5771a827dc1d60fc665d66241a4397ae571bacf5377a4ed0a8b13ab22d6a72fb9a32b1f408f0a6f8908b11bf226f394e0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/106f165792f38bb6ddfbdd39e67793ec60381131908f2cd74ca93c6b6cbcba541357d770128662aefded460b925e4e4d7d4c4c7779b1341246c5d23713bed6d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c0e6caa57085edb4bdd5598394fcb6f315de2d725be8da868856e6005b06d672af2410a7d4534b36a47b20d528002f98c30ff72507b198ed824b99440323023"} 18:50:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:18 INFO - Contents: 18:50:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a30bb68cf16050b76067b9573e6e5771a827dc1d60fc665d66241a4397ae571bacf5377a4ed0a8b13ab22d6a72fb9a32b1f408f0a6f8908b11bf226f394e0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/106f165792f38bb6ddfbdd39e67793ec60381131908f2cd74ca93c6b6cbcba541357d770128662aefded460b925e4e4d7d4c4c7779b1341246c5d23713bed6d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c0e6caa57085edb4bdd5598394fcb6f315de2d725be8da868856e6005b06d672af2410a7d4534b36a47b20d528002f98c30ff72507b198ed824b99440323023"} 18:50:18 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:18 INFO - Copying logs to upload dir... 18:50:18 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.378932 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-05 18:50:18.264682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 18:50:18.268710) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277 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/Firefox-Non-PGO/sha512/1a30bb68cf16050b76067b9573e6e5771a827dc1d60fc665d66241a4397ae571bacf5377a4ed0a8b13ab22d6a72fb9a32b1f408f0a6f8908b11bf226f394e0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/106f165792f38bb6ddfbdd39e67793ec60381131908f2cd74ca93c6b6cbcba541357d770128662aefded460b925e4e4d7d4c4c7779b1341246c5d23713bed6d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c0e6caa57085edb4bdd5598394fcb6f315de2d725be8da868856e6005b06d672af2410a7d4534b36a47b20d528002f98c30ff72507b198ed824b99440323023"} build_url:https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/EDT63JoTSB2CuJGAXF91Kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1a30bb68cf16050b76067b9573e6e5771a827dc1d60fc665d66241a4397ae571bacf5377a4ed0a8b13ab22d6a72fb9a32b1f408f0a6f8908b11bf226f394e0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/106f165792f38bb6ddfbdd39e67793ec60381131908f2cd74ca93c6b6cbcba541357d770128662aefded460b925e4e4d7d4c4c7779b1341246c5d23713bed6d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c0e6caa57085edb4bdd5598394fcb6f315de2d725be8da868856e6005b06d672af2410a7d4534b36a47b20d528002f98c30ff72507b198ed824b99440323023"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 18:50:18.296891) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:50:18.297390) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467768093.804754-1620100277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004294 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:50:18.379108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 18:50:18.379599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 18:50:18.380063) ========= ========= Total master_lag: 0.18 =========