builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1467915688.58 results: success (0) buildid: 20160707083024 builduid: 91f7a7955af84a0fa5da7cfc080ab966 revision: e2f5a7c70b47be82f2a8f85cac59482c8f77550a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.578808) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.579238) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.579550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.607055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.607425) ========= 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=df17445c3590ff7897617a0e00000225-1467915683.891085-481255111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 11:21: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-07-07 11:21:28 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.690857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.691170) ========= 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=df17445c3590ff7897617a0e00000225-1467915683.891085-481255111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015024 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.740406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:28.740767) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e2f5a7c70b47be82f2a8f85cac59482c8f77550a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e2f5a7c70b47be82f2a8f85cac59482c8f77550a --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=df17445c3590ff7897617a0e00000225-1467915683.891085-481255111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 11:21:28,798 truncating revision to first 12 chars 2016-07-07 11:21:28,799 Setting DEBUG logging. 2016-07-07 11:21:28,799 attempt 1/10 2016-07-07 11:21:28,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e2f5a7c70b47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 11:21:29,401 unpacking tar archive at: fx-team-e2f5a7c70b47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.938578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:29.693075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:29.693423) ========= script_repo_revision: e2f5a7c70b47be82f2a8f85cac59482c8f77550a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:29.693870) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:29.694139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 11:21:29.704062) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-07 11:21:29.704477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=df17445c3590ff7897617a0e00000225-1467915683.891085-481255111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:21:29 INFO - MultiFileLogger online at 20160707 11:21:29 in /builds/slave/test 11:21:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:21:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:21:29 INFO - {'append_to_log': False, 11:21:29 INFO - 'base_work_dir': '/builds/slave/test', 11:21:29 INFO - 'blob_upload_branch': 'Fx-Team', 11:21:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:21:29 INFO - 'branch': 'Fx-Team', 11:21:29 INFO - 'buildbot_json_path': 'buildprops.json', 11:21:29 INFO - 'config_files': ('talos/linux_config.py',), 11:21:29 INFO - 'default_actions': ('clobber', 11:21:29 INFO - 'read-buildbot-config', 11:21:29 INFO - 'download-and-extract', 11:21:29 INFO - 'populate-webroot', 11:21:29 INFO - 'create-virtualenv', 11:21:29 INFO - 'install', 11:21:29 INFO - 'run-tests'), 11:21:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:21:29 INFO - 'download_minidump_stackwalk': True, 11:21:29 INFO - 'download_symbols': 'ondemand', 11:21:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:21:29 INFO - 'tooltool.py': '/tools/tooltool.py', 11:21:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:21:29 INFO - '/tools/misc-python/virtualenv.py')}, 11:21:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:21:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:21:29 INFO - 'installer_path': 'installer.exe', 11:21:29 INFO - 'log_level': 'info', 11:21:29 INFO - 'log_name': 'talos', 11:21:29 INFO - 'log_to_console': True, 11:21:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:21:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:21:29 INFO - 'opt_config_files': (), 11:21:29 INFO - 'pip_index': False, 11:21:29 INFO - 'sps_profile': False, 11:21:29 INFO - 'sps_profile_interval': 0, 11:21:29 INFO - 'suite': 'dromaeojs', 11:21:29 INFO - 'system_bits': '32', 11:21:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:21:29 INFO - 'title': 'talos-linux64-ix-021', 11:21:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:21:29 INFO - 'use_talos_json': True, 11:21:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:21:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:21:29 INFO - 'work_dir': 'build'} 11:21:29 INFO - ##### 11:21:29 INFO - ##### Running clobber step. 11:21:29 INFO - ##### 11:21:29 INFO - Running pre-action listener: _resource_record_pre_action 11:21:29 INFO - Running main action method: clobber 11:21:29 INFO - rmtree: /builds/slave/test/build 11:21:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:21:30 INFO - Running post-action listener: _resource_record_post_action 11:21:30 INFO - ##### 11:21:30 INFO - ##### Finished clobber step (success) 11:21:30 INFO - ##### 11:21:30 INFO - ##### 11:21:30 INFO - ##### Running read-buildbot-config step. 11:21:30 INFO - ##### 11:21:30 INFO - Running pre-action listener: _resource_record_pre_action 11:21:30 INFO - Running main action method: read_buildbot_config 11:21:30 INFO - Using buildbot properties: 11:21:30 INFO - { 11:21:30 INFO - "project": "", 11:21:30 INFO - "product": "firefox", 11:21:30 INFO - "script_repo_revision": "production", 11:21:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:21:30 INFO - "repository": "", 11:21:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:21:30 INFO - "buildid": "20160707083024", 11:21:30 INFO - "pgo_build": "True", 11:21:30 INFO - "basedir": "/builds/slave/test", 11:21:30 INFO - "buildnumber": 256, 11:21:30 INFO - "slavename": "talos-linux64-ix-021", 11:21:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:21:30 INFO - "platform": "ubuntu64_hw", 11:21:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:21:30 INFO - "branch": "fx-team", 11:21:30 INFO - "repo_path": "integration/fx-team", 11:21:30 INFO - "revision": "e2f5a7c70b47be82f2a8f85cac59482c8f77550a", 11:21:30 INFO - "stage_platform": "linux64-pgo", 11:21:30 INFO - "builduid": "91f7a7955af84a0fa5da7cfc080ab966", 11:21:30 INFO - "slavebuilddir": "test" 11:21:30 INFO - } 11:21:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:21:30 INFO - Running post-action listener: _resource_record_post_action 11:21:30 INFO - ##### 11:21:30 INFO - ##### Finished read-buildbot-config step (success) 11:21:30 INFO - ##### 11:21:30 INFO - ##### 11:21:30 INFO - ##### Running download-and-extract step. 11:21:30 INFO - ##### 11:21:30 INFO - Running pre-action listener: _resource_record_pre_action 11:21:30 INFO - Running main action method: download_and_extract 11:21:30 INFO - mkdir: /builds/slave/test/build/tests 11:21: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')]} 11:21:30 INFO - https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:21:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:21:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:21:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:31 INFO - Downloaded 1361 bytes. 11:21:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:21:31 INFO - Using the following test package requirements: 11:21:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:21:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:21:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:21:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:31 INFO - u'jsshell-linux-x86_64.zip'], 11:21:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:21:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:21:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:21:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:21:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:21:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:21:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:21:31 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')]} 11:21:31 INFO - https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:32 INFO - Downloaded 24303637 bytes. 11:21:32 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'] 11:21:32 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 11:21:34 INFO - Return code: 0 11:21:34 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 11:21: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')]} 11:21:34 INFO - https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:21:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:21:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:35 INFO - Downloaded 24303637 bytes. 11:21:35 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'] 11:21:35 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 11:21:36 INFO - Return code: 0 11:21:36 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')]} 11:21:36 INFO - https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:21:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:21:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:21:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:37 INFO - Downloaded 14403333 bytes. 11:21:37 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'] 11:21:37 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 11:21:37 INFO - Return code: 0 11:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:37 INFO - https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BjtehvBsQgeSpne-bfpVhw/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 11:21:39 INFO - Downloaded 60447254 bytes. 11:21:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:39 INFO - mkdir: /builds/slave/test/properties 11:21:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:21:39 INFO - Writing to file /builds/slave/test/properties/build_url 11:21:39 INFO - Contents: 11:21:39 INFO - build_url:https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:21:39 INFO - Running post-action listener: _resource_record_post_action 11:21:39 INFO - Running post-action listener: set_extra_try_arguments 11:21:39 INFO - ##### 11:21:39 INFO - ##### Finished download-and-extract step (success) 11:21:39 INFO - ##### 11:21:39 INFO - ##### 11:21:39 INFO - ##### Running populate-webroot step. 11:21:39 INFO - ##### 11:21:39 INFO - Running pre-action listener: _resource_record_pre_action 11:21:39 INFO - Running main action method: populate_webroot 11:21:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:21:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:21:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:21:39 INFO - '--tppagecycles', 11:21:39 INFO - '7'], 11:21:39 INFO - 'tests': ['tsvgm']}}, 11:21:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:21:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:21:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:21:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:21:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:39 INFO - 'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:39 INFO - 'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['damp', 'tps']}, 11:21:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:39 INFO - 'tests': ['damp', 'tps']}, 11:21:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['dromaeo_dom']}, 11:21:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:21:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['basic_compositor_video']}, 11:21:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:21:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['a11yr', 11:21:39 INFO - 'ts_paint', 11:21:39 INFO - 'tpaint', 11:21:39 INFO - 'sessionrestore', 11:21:39 INFO - 'sessionrestore_no_auto_restore', 11:21:39 INFO - 'tabpaint']}, 11:21:39 INFO - 'other-e10s': {'tests': ['a11yr', 11:21:39 INFO - 'ts_paint', 11:21:39 INFO - 'tpaint', 11:21:39 INFO - 'sessionrestore', 11:21:39 INFO - 'sessionrestore_no_auto_restore', 11:21:39 INFO - 'tabpaint']}, 11:21:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:21:39 INFO - 'ts_paint', 11:21:39 INFO - 'tpaint', 11:21:39 INFO - 'sessionrestore', 11:21:39 INFO - 'sessionrestore_no_auto_restore', 11:21:39 INFO - 'tabpaint']}, 11:21:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:21:39 INFO - 'ts_paint', 11:21:39 INFO - 'tpaint', 11:21:39 INFO - 'sessionrestore', 11:21:39 INFO - 'sessionrestore_no_auto_restore', 11:21:39 INFO - 'tabpaint']}, 11:21:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['a11yr', 11:21:39 INFO - 'ts_paint', 11:21:39 INFO - 'tpaint', 11:21:39 INFO - 'sessionrestore', 11:21:39 INFO - 'sessionrestore_no_auto_restore', 11:21:39 INFO - 'tabpaint']}, 11:21:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['a11yr', 11:21:39 INFO - 'ts_paint', 11:21:39 INFO - 'tpaint', 11:21:39 INFO - 'sessionrestore', 11:21:39 INFO - 'sessionrestore_no_auto_restore', 11:21:39 INFO - 'tabpaint']}, 11:21:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['tsvgx', 11:21:39 INFO - 'tsvgr_opacity', 11:21:39 INFO - 'tart', 11:21:39 INFO - 'tscrollx', 11:21:39 INFO - 'cart']}, 11:21:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:21:39 INFO - 'tsvgr_opacity', 11:21:39 INFO - 'tart', 11:21:39 INFO - 'tscrollx', 11:21:39 INFO - 'cart']}, 11:21:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:39 INFO - 'talos_options': ['--disable-e10s'], 11:21:39 INFO - 'tests': ['tp5o']}, 11:21:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:39 INFO - 'tests': ['tp5o']}, 11:21:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:39 INFO - 'talos_options': ['--disable-e10s', 11:21:39 INFO - '--xperf_path', 11:21:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:39 INFO - 'tests': ['tp5n']}, 11:21:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:39 INFO - 'talos_options': ['--xperf_path', 11:21:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:39 INFO - 'tests': ['tp5n']}}, 11:21:39 INFO - 'talos.zip': {'path': '', 11:21:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:21:39 INFO - Running post-action listener: _resource_record_post_action 11:21:39 INFO - ##### 11:21:39 INFO - ##### Finished populate-webroot step (success) 11:21:39 INFO - ##### 11:21:39 INFO - ##### 11:21:39 INFO - ##### Running create-virtualenv step. 11:21:39 INFO - ##### 11:21:39 INFO - Running pre-action listener: _resource_record_pre_action 11:21:39 INFO - Running main action method: create_virtualenv 11:21:39 INFO - Creating virtualenv /builds/slave/test/build/venv 11:21:39 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 11:21:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:21:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:21:40 INFO - Using real prefix '/usr' 11:21:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:21:40 INFO - Installing distribute.............................................................................................................................................................................................done. 11:21:42 INFO - Installing pip.................done. 11:21:42 INFO - Return code: 0 11:21:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:21:42 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')]} 11:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:42 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')]} 11:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:42 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:21:42 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 11:21:42 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 11:21:42 INFO - Using env: {'DISPLAY': ':0', 11:21:42 INFO - 'HOME': '/home/cltbld', 11:21:42 INFO - 'LANG': 'en_US.UTF-8', 11:21:42 INFO - 'LANGUAGE': 'en_US:en', 11:21:42 INFO - 'LOGNAME': 'cltbld', 11:21:42 INFO - 'MAIL': '/var/mail/cltbld', 11:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:42 INFO - 'MOZ_NO_REMOTE': '1', 11:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:42 INFO - 'NO_EM_RESTART': '1', 11:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:42 INFO - 'PWD': '/builds/slave/test', 11:21:42 INFO - 'SHELL': '/bin/bash', 11:21:42 INFO - 'SHLVL': '1', 11:21:42 INFO - 'TERM': 'linux', 11:21:42 INFO - 'TMOUT': '86400', 11:21:42 INFO - 'USER': 'cltbld', 11:21:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:42 INFO - '_': '/tools/buildbot/bin/python'} 11:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:42 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 11:21:42 INFO - Cleaning up... 11:21:42 INFO - Return code: 0 11:21:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:21:42 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')]} 11:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:42 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')]} 11:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:42 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:21:42 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 11:21:42 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 11:21:42 INFO - Using env: {'DISPLAY': ':0', 11:21:42 INFO - 'HOME': '/home/cltbld', 11:21:42 INFO - 'LANG': 'en_US.UTF-8', 11:21:42 INFO - 'LANGUAGE': 'en_US:en', 11:21:42 INFO - 'LOGNAME': 'cltbld', 11:21:42 INFO - 'MAIL': '/var/mail/cltbld', 11:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:42 INFO - 'MOZ_NO_REMOTE': '1', 11:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:42 INFO - 'NO_EM_RESTART': '1', 11:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:42 INFO - 'PWD': '/builds/slave/test', 11:21:42 INFO - 'SHELL': '/bin/bash', 11:21:42 INFO - 'SHLVL': '1', 11:21:42 INFO - 'TERM': 'linux', 11:21:42 INFO - 'TMOUT': '86400', 11:21:42 INFO - 'USER': 'cltbld', 11:21:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:42 INFO - '_': '/tools/buildbot/bin/python'} 11:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:42 INFO - Downloading/unpacking psutil>=3.1.1 11:21:42 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 11:21:42 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 11:21:42 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 11:21:42 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 11:21:42 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 11:21:42 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 11:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:21:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:44 INFO - Installing collected packages: psutil 11:21:44 INFO - Running setup.py install for psutil 11:21:45 INFO - building 'psutil._psutil_linux' extension 11:21:45 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 11:21:45 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 11:21:45 INFO - building 'psutil._psutil_posix' extension 11:21:45 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 11:21:45 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 11:21:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:45 INFO - Successfully installed psutil 11:21:45 INFO - Cleaning up... 11:21:45 INFO - Return code: 0 11:21:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:45 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:21:45 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 11:21:45 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 11:21:45 INFO - Using env: {'DISPLAY': ':0', 11:21:45 INFO - 'HOME': '/home/cltbld', 11:21:45 INFO - 'LANG': 'en_US.UTF-8', 11:21:45 INFO - 'LANGUAGE': 'en_US:en', 11:21:45 INFO - 'LOGNAME': 'cltbld', 11:21:45 INFO - 'MAIL': '/var/mail/cltbld', 11:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:45 INFO - 'MOZ_NO_REMOTE': '1', 11:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:45 INFO - 'NO_EM_RESTART': '1', 11:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:45 INFO - 'PWD': '/builds/slave/test', 11:21:45 INFO - 'SHELL': '/bin/bash', 11:21:45 INFO - 'SHLVL': '1', 11:21:45 INFO - 'TERM': 'linux', 11:21:45 INFO - 'TMOUT': '86400', 11:21:45 INFO - 'USER': 'cltbld', 11:21:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:45 INFO - '_': '/tools/buildbot/bin/python'} 11:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:21:45 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 11:21:45 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 11:21:45 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 11:21:45 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 11:21:45 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 11:21:45 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 11:21:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:21:47 INFO - Installing collected packages: mozsystemmonitor 11:21:47 INFO - Running setup.py install for mozsystemmonitor 11:21:47 INFO - Successfully installed mozsystemmonitor 11:21:47 INFO - Cleaning up... 11:21:47 INFO - Return code: 0 11:21:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:47 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:21:47 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 11:21:47 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 11:21:47 INFO - Using env: {'DISPLAY': ':0', 11:21:47 INFO - 'HOME': '/home/cltbld', 11:21:47 INFO - 'LANG': 'en_US.UTF-8', 11:21:47 INFO - 'LANGUAGE': 'en_US:en', 11:21:47 INFO - 'LOGNAME': 'cltbld', 11:21:47 INFO - 'MAIL': '/var/mail/cltbld', 11:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:47 INFO - 'MOZ_NO_REMOTE': '1', 11:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:47 INFO - 'NO_EM_RESTART': '1', 11:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:47 INFO - 'PWD': '/builds/slave/test', 11:21:47 INFO - 'SHELL': '/bin/bash', 11:21:47 INFO - 'SHLVL': '1', 11:21:47 INFO - 'TERM': 'linux', 11:21:47 INFO - 'TMOUT': '86400', 11:21:47 INFO - 'USER': 'cltbld', 11:21:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:47 INFO - '_': '/tools/buildbot/bin/python'} 11:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:48 INFO - Downloading/unpacking jsonschema==2.5.1 11:21:48 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 11:21:48 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 11:21:48 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 11:21:48 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 11:21:48 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 11:21:48 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 11:21:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:49 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 11:21:49 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 11:21:49 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 11:21:49 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 11:21:49 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 11:21:49 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 11:21:50 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:50 INFO - warning: no files found matching '*.txt' 11:21:50 INFO - no previously-included directories found matching 'build' 11:21:50 INFO - no previously-included directories found matching 'dist' 11:21:50 INFO - no previously-included directories found matching '.git*' 11:21:50 INFO - Installing collected packages: jsonschema, functools32 11:21:50 INFO - Running setup.py install for functools32 11:21:50 INFO - warning: no files found matching '*.txt' 11:21:50 INFO - no previously-included directories found matching 'build' 11:21:50 INFO - no previously-included directories found matching 'dist' 11:21:50 INFO - no previously-included directories found matching '.git*' 11:21:50 INFO - Successfully installed jsonschema functools32 11:21:50 INFO - Cleaning up... 11:21:50 INFO - Return code: 0 11:21:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21:50 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')]} 11:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:50 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')]} 11:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:50 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:21:50 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 11:21:50 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 11:21:50 INFO - Using env: {'DISPLAY': ':0', 11:21:50 INFO - 'HOME': '/home/cltbld', 11:21:50 INFO - 'LANG': 'en_US.UTF-8', 11:21:50 INFO - 'LANGUAGE': 'en_US:en', 11:21:50 INFO - 'LOGNAME': 'cltbld', 11:21:50 INFO - 'MAIL': '/var/mail/cltbld', 11:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:50 INFO - 'MOZ_NO_REMOTE': '1', 11:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:50 INFO - 'NO_EM_RESTART': '1', 11:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:50 INFO - 'PWD': '/builds/slave/test', 11:21:50 INFO - 'SHELL': '/bin/bash', 11:21:50 INFO - 'SHLVL': '1', 11:21:50 INFO - 'TERM': 'linux', 11:21:50 INFO - 'TMOUT': '86400', 11:21:50 INFO - 'USER': 'cltbld', 11:21:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:50 INFO - '_': '/tools/buildbot/bin/python'} 11:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:21:50 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 11:21:50 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 11:21:50 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 11:21:50 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 11:21:50 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 11:21:50 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 11:21:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:52 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 11:21:52 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 11:21:52 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 11:21:52 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 11:21:52 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 11:21:52 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 11:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:52 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 11:21:52 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 11:21:52 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 11:21:52 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 11:21:52 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 11:21:52 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 11:21:53 INFO - Downloading docopt-0.6.1.tar.gz 11:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:53 INFO - Running setup.py install for blobuploader 11:21:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:53 INFO - Running setup.py install for requests 11:21:53 INFO - Running setup.py install for docopt 11:21:53 INFO - Successfully installed blobuploader requests docopt 11:21:53 INFO - Cleaning up... 11:21:53 INFO - Return code: 0 11:21:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:53 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')]} 11:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:53 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')]} 11:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:53 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:21:53 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 11:21:53 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 11:21:53 INFO - Using env: {'DISPLAY': ':0', 11:21:53 INFO - 'HOME': '/home/cltbld', 11:21:53 INFO - 'LANG': 'en_US.UTF-8', 11:21:53 INFO - 'LANGUAGE': 'en_US:en', 11:21:53 INFO - 'LOGNAME': 'cltbld', 11:21:53 INFO - 'MAIL': '/var/mail/cltbld', 11:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:53 INFO - 'MOZ_NO_REMOTE': '1', 11:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:53 INFO - 'NO_EM_RESTART': '1', 11:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:53 INFO - 'PWD': '/builds/slave/test', 11:21:53 INFO - 'SHELL': '/bin/bash', 11:21:53 INFO - 'SHLVL': '1', 11:21:53 INFO - 'TERM': 'linux', 11:21:53 INFO - 'TMOUT': '86400', 11:21:53 INFO - 'USER': 'cltbld', 11:21:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:53 INFO - '_': '/tools/buildbot/bin/python'} 11:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:54 INFO - Running setup.py (path:/tmp/pip-8Fw4K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:54 INFO - Running setup.py (path:/tmp/pip-pXYrN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:54 INFO - Running setup.py (path:/tmp/pip-2JtDH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:54 INFO - Running setup.py (path:/tmp/pip-AwoJbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:54 INFO - Running setup.py (path:/tmp/pip-wiKEqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:54 INFO - Running setup.py (path:/tmp/pip-DF_27r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:54 INFO - Running setup.py (path:/tmp/pip-VJd4p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:54 INFO - Running setup.py (path:/tmp/pip-9hPka_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:54 INFO - Running setup.py (path:/tmp/pip-tBb46S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:54 INFO - Running setup.py (path:/tmp/pip-g4oIAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:54 INFO - Running setup.py (path:/tmp/pip-_tKgSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:54 INFO - Running setup.py (path:/tmp/pip-A0InDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:54 INFO - Running setup.py (path:/tmp/pip-RQRUjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:55 INFO - Running setup.py (path:/tmp/pip-214Jp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:55 INFO - Running setup.py (path:/tmp/pip-5j_JM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:55 INFO - Running setup.py (path:/tmp/pip-Ws_AYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:55 INFO - Running setup.py (path:/tmp/pip-bUiXyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:55 INFO - Running setup.py install for manifestparser 11:21:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:55 INFO - Running setup.py install for mozcrash 11:21:55 INFO - Running setup.py install for mozdebug 11:21:55 INFO - Running setup.py install for mozdevice 11:21:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:21:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:55 INFO - Running setup.py install for mozfile 11:21:55 INFO - Running setup.py install for mozhttpd 11:21:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:55 INFO - Running setup.py install for mozinfo 11:21:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Running setup.py install for mozInstall 11:21:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Running setup.py install for mozleak 11:21:56 INFO - Running setup.py install for mozlog 11:21:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Running setup.py install for moznetwork 11:21:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Running setup.py install for mozprocess 11:21:56 INFO - Running setup.py install for mozprofile 11:21:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Running setup.py install for mozrunner 11:21:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:56 INFO - Running setup.py install for mozscreenshot 11:21:56 INFO - Running setup.py install for moztest 11:21:56 INFO - Running setup.py install for mozversion 11:21:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:57 INFO - Cleaning up... 11:21:57 INFO - Return code: 0 11:21:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:57 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:21:57 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 11:21:57 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 11:21:57 INFO - Using env: {'DISPLAY': ':0', 11:21:57 INFO - 'HOME': '/home/cltbld', 11:21:57 INFO - 'LANG': 'en_US.UTF-8', 11:21:57 INFO - 'LANGUAGE': 'en_US:en', 11:21:57 INFO - 'LOGNAME': 'cltbld', 11:21:57 INFO - 'MAIL': '/var/mail/cltbld', 11:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:57 INFO - 'MOZ_NO_REMOTE': '1', 11:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:57 INFO - 'NO_EM_RESTART': '1', 11:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:57 INFO - 'PWD': '/builds/slave/test', 11:21:57 INFO - 'SHELL': '/bin/bash', 11:21:57 INFO - 'SHLVL': '1', 11:21:57 INFO - 'TERM': 'linux', 11:21:57 INFO - 'TMOUT': '86400', 11:21:57 INFO - 'USER': 'cltbld', 11:21:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:57 INFO - '_': '/tools/buildbot/bin/python'} 11:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:57 INFO - Running setup.py (path:/tmp/pip-jcr9lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:57 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)) 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:57 INFO - Running setup.py (path:/tmp/pip-tF5T5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:57 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)) 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:57 INFO - Running setup.py (path:/tmp/pip-ZH9mEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:57 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)) 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:57 INFO - Running setup.py (path:/tmp/pip-wE5Y3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:57 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)) 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:57 INFO - Running setup.py (path:/tmp/pip-XquLNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:57 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)) 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:57 INFO - Running setup.py (path:/tmp/pip-SGVoxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:57 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)) 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:57 INFO - Running setup.py (path:/tmp/pip-pkWzjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:57 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)) 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:57 INFO - Running setup.py (path:/tmp/pip-4Smev_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:57 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)) 11:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:57 INFO - Running setup.py (path:/tmp/pip-kweK1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:58 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)) 11:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:58 INFO - Running setup.py (path:/tmp/pip-xvPDXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:58 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)) 11:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:58 INFO - Running setup.py (path:/tmp/pip-7bU54X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:58 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)) 11:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:58 INFO - Running setup.py (path:/tmp/pip-oaggwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:58 INFO - Running setup.py (path:/tmp/pip-kYYFiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:58 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)) 11:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:58 INFO - Running setup.py (path:/tmp/pip-lbtmDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:58 INFO - Running setup.py (path:/tmp/pip-pXDnjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:58 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)) 11:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:58 INFO - Running setup.py (path:/tmp/pip-dmPAYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:58 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)) 11:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:58 INFO - Running setup.py (path:/tmp/pip-Wndtjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:58 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)) 11:21:58 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)) 11:21:58 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)) 11:21:58 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)) 11:21:58 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)) 11:21:58 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)) 11:21:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21: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 11:21: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 11:21: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 11:21: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 11:21: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 11:21: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 11:22:00 INFO - Downloading blessings-1.6.tar.gz 11:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:00 INFO - Installing collected packages: blessings 11:22:00 INFO - Running setup.py install for blessings 11:22:00 INFO - Successfully installed blessings 11:22:00 INFO - Cleaning up... 11:22:00 INFO - Return code: 0 11:22:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:00 INFO - Reading from file tmpfile_stdout 11:22:00 INFO - Current package versions: 11:22:00 INFO - argparse == 1.2.1 11:22:00 INFO - blessings == 1.6 11:22:00 INFO - blobuploader == 1.2.4 11:22:00 INFO - docopt == 0.6.1 11:22:00 INFO - functools32 == 3.2.3-2 11:22:00 INFO - jsonschema == 2.5.1 11:22:00 INFO - manifestparser == 1.1 11:22:00 INFO - mozInstall == 1.12 11:22:00 INFO - mozcrash == 0.17 11:22:00 INFO - mozdebug == 0.1 11:22:00 INFO - mozdevice == 0.48 11:22:00 INFO - mozfile == 1.2 11:22:00 INFO - mozhttpd == 0.7 11:22:00 INFO - mozinfo == 0.9 11:22:00 INFO - mozleak == 0.1 11:22:00 INFO - mozlog == 3.2 11:22:00 INFO - moznetwork == 0.27 11:22:00 INFO - mozprocess == 0.23 11:22:00 INFO - mozprofile == 0.28 11:22:00 INFO - mozrunner == 6.12 11:22:00 INFO - mozscreenshot == 0.1 11:22:00 INFO - mozsystemmonitor == 0.3 11:22:00 INFO - moztest == 0.7 11:22:00 INFO - mozversion == 1.4 11:22:00 INFO - psutil == 3.1.1 11:22:00 INFO - requests == 1.2.3 11:22:00 INFO - wsgiref == 0.1.2 11:22:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:00 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:22:00 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 11:22:00 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 11:22:00 INFO - Using env: {'DISPLAY': ':0', 11:22:00 INFO - 'HOME': '/home/cltbld', 11:22:00 INFO - 'LANG': 'en_US.UTF-8', 11:22:00 INFO - 'LANGUAGE': 'en_US:en', 11:22:00 INFO - 'LOGNAME': 'cltbld', 11:22:00 INFO - 'MAIL': '/var/mail/cltbld', 11:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:00 INFO - 'MOZ_NO_REMOTE': '1', 11:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:00 INFO - 'NO_EM_RESTART': '1', 11:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:00 INFO - 'PWD': '/builds/slave/test', 11:22:00 INFO - 'SHELL': '/bin/bash', 11:22:00 INFO - 'SHLVL': '1', 11:22:00 INFO - 'TERM': 'linux', 11:22:00 INFO - 'TMOUT': '86400', 11:22:00 INFO - 'USER': 'cltbld', 11:22:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:00 INFO - '_': '/tools/buildbot/bin/python'} 11:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 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)) 11:22:01 INFO - Cleaning up... 11:22:01 INFO - Return code: 0 11:22:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:01 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 0x12d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, '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': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', '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 11:22:01 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 11:22:01 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 11:22:01 INFO - Using env: {'DISPLAY': ':0', 11:22:01 INFO - 'HOME': '/home/cltbld', 11:22:01 INFO - 'LANG': 'en_US.UTF-8', 11:22:01 INFO - 'LANGUAGE': 'en_US:en', 11:22:01 INFO - 'LOGNAME': 'cltbld', 11:22:01 INFO - 'MAIL': '/var/mail/cltbld', 11:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:01 INFO - 'MOZ_NO_REMOTE': '1', 11:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:01 INFO - 'NO_EM_RESTART': '1', 11:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:01 INFO - 'PWD': '/builds/slave/test', 11:22:01 INFO - 'SHELL': '/bin/bash', 11:22:01 INFO - 'SHLVL': '1', 11:22:01 INFO - 'TERM': 'linux', 11:22:01 INFO - 'TMOUT': '86400', 11:22:01 INFO - 'USER': 'cltbld', 11:22:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:01 INFO - '_': '/tools/buildbot/bin/python'} 11:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:01 INFO - Cleaning up... 11:22:01 INFO - Return code: 0 11:22:01 INFO - Running post-action listener: _resource_record_post_action 11:22:01 INFO - Running post-action listener: _start_resource_monitoring 11:22:01 INFO - Starting resource monitoring. 11:22:01 INFO - ##### 11:22:01 INFO - ##### Finished create-virtualenv step (success) 11:22:01 INFO - ##### 11:22:01 INFO - ##### 11:22:01 INFO - ##### Running install step. 11:22:01 INFO - ##### 11:22:01 INFO - Running pre-action listener: _resource_record_pre_action 11:22:01 INFO - Running main action method: install 11:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:01 INFO - Reading from file tmpfile_stdout 11:22:01 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:01 INFO - Reading from file tmpfile_stdout 11:22:01 INFO - Output received: 11:22:01 INFO - Usage: mozinstall [options] installer 11:22:01 INFO - Options: 11:22:01 INFO - -h, --help show this help message and exit 11:22:01 INFO - -d DEST, --destination=DEST 11:22:01 INFO - Directory to install application into. [default: 11:22:01 INFO - "/builds/slave/test"] 11:22:01 INFO - --app=APP Application being installed. [default: firefox] 11:22:01 INFO - mkdir: /builds/slave/test/build/application 11:22:01 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'] 11:22:01 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 11:22:19 INFO - Reading from file tmpfile_stdout 11:22:19 INFO - Output received: 11:22:19 INFO - /builds/slave/test/build/application/firefox/firefox 11:22:19 INFO - Running post-action listener: _resource_record_post_action 11:22:19 INFO - ##### 11:22:19 INFO - ##### Finished install step (success) 11:22:19 INFO - ##### 11:22:19 INFO - ##### 11:22:19 INFO - ##### Running run-tests step. 11:22:19 INFO - ##### 11:22:19 INFO - Running pre-action listener: _resource_record_pre_action 11:22:19 INFO - Running main action method: run_tests 11:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:22:19 INFO - Python 2.7.3 11:22:19 INFO - Return code: 0 11:22:19 INFO - grabbing minidump binary from tooltool 11:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:19 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 0x15983b0>, '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 0x15992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1599740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:22:19 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 11:22:19 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 11:22:19 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 11:22:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:19 INFO - Return code: 0 11:22:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:22:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:22:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:22:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:22:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:22:19 INFO - Using env: {'DISPLAY': ':0', 11:22:19 INFO - 'HOME': '/home/cltbld', 11:22:19 INFO - 'LANG': 'en_US.UTF-8', 11:22:19 INFO - 'LANGUAGE': 'en_US:en', 11:22:19 INFO - 'LOGNAME': 'cltbld', 11:22:19 INFO - 'MAIL': '/var/mail/cltbld', 11:22:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:19 INFO - 'MOZ_NO_REMOTE': '1', 11:22:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:19 INFO - 'NO_EM_RESTART': '1', 11:22:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:19 INFO - 'PWD': '/builds/slave/test', 11:22:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:19 INFO - 'SHELL': '/bin/bash', 11:22:19 INFO - 'SHLVL': '1', 11:22:19 INFO - 'TERM': 'linux', 11:22:19 INFO - 'TMOUT': '86400', 11:22:19 INFO - 'USER': 'cltbld', 11:22:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467915683.891085-481255111', 11:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:19 INFO - '_': '/tools/buildbot/bin/python'} 11:22:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:22:19 INFO - mozversion application_buildid: 20160707083024 11:22:19 INFO - mozversion application_changeset: e2f5a7c70b47be82f2a8f85cac59482c8f77550a 11:22:19 INFO - mozversion application_display_name: Nightly 11:22:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:19 INFO - mozversion application_name: Firefox 11:22:19 INFO - mozversion application_remotingname: firefox 11:22:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:22:19 INFO - mozversion application_vendor: Mozilla 11:22:19 INFO - mozversion application_version: 50.0a1 11:22:19 INFO - mozversion platform_buildid: 20160707083024 11:22:19 INFO - mozversion platform_changeset: e2f5a7c70b47be82f2a8f85cac59482c8f77550a 11:22:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:22:19 INFO - mozversion platform_version: 50.0a1 11:22:19 INFO - using testdate: 1467915739 11:22:19 INFO - actual date: 1467915739 11:22:19 INFO - starting webserver on 'localhost:36496' 11:22:19 INFO - SUITE-START | Running 2 tests 11:22:19 INFO - TEST-START | dromaeo_css 11:22:19 INFO - operating with platform_type : linux_ 11:22:19 INFO - Initialising browser for dromaeo_css test... 11:22:19 INFO - TEST-INFO | started process 18026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwd_Fqy/profile http://localhost:36496/getInfo.html) 11:22:24 INFO - PROCESS | 18026 | __metrics Screen width/height:1600/1200 11:22:24 INFO - PROCESS | 18026 | colorDepth:24 11:22:24 INFO - PROCESS | 18026 | Browser inner width/height: 1024/697 11:22:24 INFO - PROCESS | 18026 | __metrics 11:22:25 INFO - PROCESS | 18026 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:22:25 INFO - PROCESS | 18026 | console.error: PushService: 11:22:25 INFO - PROCESS | 18026 | stateChangeProcessEnqueue: Error transitioning state 11:22:25 INFO - PROCESS | 18026 | UnknownError 11:22:26 INFO - TEST-INFO | 18026: exit 0 11:22:26 INFO - Browser initialized. 11:22:26 INFO - Running cycle 1/1 for dromaeo_css test... 11:22:26 INFO - TEST-INFO | started process 18109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwd_Fqy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:38 INFO - PROCESS | 18109 | RSS: Main: 157380608 11:22:38 INFO - PROCESS | 18109 | 11:23:28 INFO - PROCESS | 18109 | 1467915808726 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] 11:25:37 INFO - PROCESS | 18109 | Cycle 1(1): loaded http://localhost:36496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36496/tests/dromaeo/cssquery-ext.html) 11:25:38 INFO - PROCESS | 18109 | RSS: Main: 245059584 11:25:38 INFO - PROCESS | 18109 | 11:28:41 INFO - PROCESS | 18109 | Cycle 1(1): loaded http://localhost:36496/tests/dromaeo/cssquery-ext.html (next: http://localhost:36496/tests/dromaeo/cssquery-jquery.html) 11:28:41 INFO - PROCESS | 18109 | RSS: Main: 241614848 11:28:41 INFO - PROCESS | 18109 | 11:31:43 INFO - PROCESS | 18109 | Cycle 1(1): loaded http://localhost:36496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36496/tests/dromaeo/cssquery-mootools.html) 11:31:44 INFO - PROCESS | 18109 | RSS: Main: 252289024 11:31:44 INFO - PROCESS | 18109 | 11:34:46 INFO - PROCESS | 18109 | Cycle 1(1): loaded http://localhost:36496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36496/tests/dromaeo/cssquery-prototype.html) 11:34:46 INFO - PROCESS | 18109 | RSS: Main: 243195904 11:34:46 INFO - PROCESS | 18109 | 11:37:49 INFO - PROCESS | 18109 | Cycle 1(1): loaded http://localhost:36496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36496/tests/dromaeo/cssquery-yui.html) 11:37:50 INFO - PROCESS | 18109 | RSS: Main: 234889216 11:37:50 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | Cycle 1(1): loaded http://localhost:36496/tests/dromaeo/cssquery-yui.html (next: http://localhost:36496/tests/dromaeo/cssquery-dojo.html) 11:40:52 INFO - PROCESS | 18109 | RSS: Main: 310419456 11:40:52 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | __start_tp_report 11:40:52 INFO - PROCESS | 18109 | _x_x_mozilla_page_load 11:40:52 INFO - PROCESS | 18109 | _x_x_mozilla_page_load_details 11:40:52 INFO - PROCESS | 18109 | |i|pagename|runs| 11:40:52 INFO - PROCESS | 18109 | |0;dojo.html;3106.953395699065;3111.8599663015166;3136.8745250189995;3151.6060492438446;3166.73082787963;5272.762725677344;5273.182656688219;5346.331708536433;5350.732463376835;5380.650257733249;5328.760205790739;5376.838694839152;5388.461153884609;5427.728613569326;5451.727413629323;4861.635377346704;4894.853154405374;4915.434725006634;4916.164252077156;5078.898422031557;4968.850934471971;5000.749962501878;5005.924911126318;5030.522100400474;5035.169197082477;4751.14479393709;4822.95177048232;4888.462269150391;4900.387451568554;4957.5786058185095;4782;4790.616750659939;4791.089692958361;4799.064182484417;4900.338454308659;4812.855614331575;4833.2266837306215;4860;4866.562009419134;4920.261960705887;5133.871653208662;5334.146536554172;5406.162044883049;5416.7020813855615;5418.29562156921;5708.058170401879;5818.883622327572;5822.708864556797;5826.883462330729;5828.271466066742;5787.652740835521;5820.35976042635;5868.03177475716;5874.9412505874825;5876.236089308405;5216.347956505437;5267.157254839208;5318.5213330800025;5335.599830012726;5410.621256512085;5905.940940590625;5925.496332811673;5928.170056192136;5928.584999050111;5932.080527518242;5377.247185394048;5693.459121383462;5693.487586117187;5696.743646535916;5706.400827913092;5618.831435056954;5662.235598194191;5675.5459563234845;5680.091185410314;5680.971595141998;5654.830355089354;5662.490375866192;5667.291588551431;5669.40471250521;5671.716414179275;5539.19681646159;5649.802256920988;5656.773729050792;5675.517581005661;5684.8863022739315;4369.43197384338;4382.517923028464;4388.385626012361;4438.1567502174485;4441.222786012435;3913.8238779254434;3926.509186351706;3935.0555866591812;3937.2912875682077;3970.741901776433;5227.581793456515;5276.894462110737;5384.219288203267;5451.3458384994055;5491.450854914477;5749.741261643236;5771.394003629643;5792.189093526909;5799.8550036249435;5850.853728656818;5415.620906536584;5433.130699088127;5449.64577302474;5455.863603409946;5459.454054594509;4832;4926.901461970812;4984.925226121611;4987.077390682735;5049.798008079709;5958.255218097738;5965.701714914324;5969.04495280753;5992.610480318765;6009.879802403927;5786.797462088806;5796.391378905154;5796.710164491674;5797.594168408171;5809.070548712186;5721.170430287668;5774.105013722879;5774.9133762994425;5810.709464526842;5969.582129250911;5551.195076713773;5552.056150454513;5565.888682226414;5571.916421253603;5577.135543990688;5612.410696876769;5651.237082993744;5654.85862853432;5657.858553536194;5662.915056274242;5497.587680924026;5556.749946252347;5581.358143813513;5599.244102046335;5631.155326701028;5611.410801865745;5612.943870561406;5621.184928185472;5622.269105016322;5623.971880140737;5385.38068122171;5514.6139770217305;5548.805791797267;5562.972185139049;5565.944340556543;5505.697186654773;5534.280543529316;5541.058020136667;5572.35917869434;5625.184348269559;5451.3458384994055;5468.589855760754;5475.972620136874;5479.287692599936;5482.671039737628 11:40:52 INFO - PROCESS | 18109 | |1;ext.html;608.0757248981548;626.8965620672591;632.0266789144717;646.9805905822827;650.6031320894257;43916;45798;45856.77071614641;45868.54131458689;49469.7526512367;46522.30216546755;46917.7654111729;46931.765341173246;46942;46991.29513057307;9061.411008284473;9195.862062069074;9199.724008279762;9210.907890921106;9218.124278193562;9077.319201059914;9100.226480749145;9137.360384773068;9166.358354915159;9168;9015.774605634879;9125;9137.817243655123;9143.674167245745;9149.496777677225;9063.637454501812;9132.863007054899;9197.724068277928;9198;9198.218151457135;9038.819223615557;9088.591013404346;9103.954480227623;9112.726618201465;9117.361784675075;44486.555134448885;44626.77686611579;44834.32748508775;44857;44869;3316.950245746292;3603.855845766166;3663.230721548478;3704.1665625234377;3814.4087666411474;33594.496082558784;34107.82946085279;34249.56630974468;34429.827850860835;35172.47241291357;4541.137183935041;4567.109413664337;4586.4266966629175;4658.673892827504;4811.687240329367;362570;363727;363933;365667;366243.168784157;54203.45796542063;59004.7049764757;60729.69635151796;61654.691726541976;62489.37510624927;63902.680486597266;63979.36020639827;64144.67927660425;64285;64366;16268.593285167966;16271.755923661154;16365.099919504542;16386.75419868703;16407.835921640868;12441.688957775947;13368.866311336957;13682.794758078637;13725.45098196081;13760.587182384545;17900.194491247927;18397.3560925367;18425.723614145798;18466.815331846778;18571.44285671432;6037.50967709705;6075.210222671025;6076.240469941257;6095.384723048396;6114.449699527064;937.9484128372868;1061.830107182847;1076.5855145768935;1116.1349953785882;1148.4081372919381;32555.837220813744;33088.3382332352;33105.50341744876;33396.66603333984;33411.164720882174;1106.856108705863;1118.0552433193939;1147.162571322939;1198.6883410313208;1204.114975493012;17372;17595;17852;17878.106094695213;17937.910310448624;566882;573577;575568;577201;578353;61464;61470.69264653648;61488.38511614916;61610.38389616136;61645;1212.902967762577;1304.5564508067303;1337.9063465557317;1371.4445649511963;1383.1839214863078;32489.187770305933;33798.15504612404;34035.82982085074;34196;34343.65656343505;53051.46948530465;53472.1979170305;53633.73183134059;53760.46239537711;53884;401520;409467;409661;409839;411536;28261.293467663472;38745.2250954985;41164.38253426261;42554.36168457538;43755;46612.300815488474;46893;49826.50173498219;50037.749811252164;50096.157658908945;41528;42821.78589107034;43102.137957240055;43132.353014704175;44587.331190032826;42047.789761051;42458;43282.56717432785;43599.78200108979;43763;42345.153096938506;42583.3612495819;43387.56612433835;43532.782336088116;43744.78127609469;33829.66170338265;36266.456003159445;36725;36844.447333289485;37184;28494.43011139807;28707.85646071756;28738.568921466613;28753;28840.278993025342 11:40:52 INFO - PROCESS | 18109 | |2;jquery.html;402.6094688152491;402.840877853248;407.58019240182614;408.8814243869276;422.7083312514365;13847.515336963208;18852.34016809412;20548.69176962345;20551.38345849623;22109.447263818412;19192.328268510606;20257.797422025775;20270.69593956092;20494.282700105497;20786.06462709178;5082.923756143661;5222.660527065728;5225.503577160182;5228.633995620308;5231.581473482112;3880.3791393377064;5177.715225662587;5218.373795144569;5223.320968274119;5225.712585807779;7314.81712957175;7708.807279817994;7725.034370703662;7728.768136955872;7870.921290787105;7288.08898887639;7559.3574546163645;7574.810629734246;7586.506877052974;7587.999999999973;7204.819879503002;7234.927650723478;7301.2333704961275;7333.413326933885;7427.92295117205;27672.723272767216;27981;28214.15357539277;28302;29351.55972660412;2546.732593077719;2607.2308668942705;2624.448865738197;3088.119885832527;3160.873565057395;16529.6694066118;16652.50042498727;16879.24043418049;17131.914340428342;17151.399701010403;2076.7611724651556;2155.504234026183;2167.6856855755827;2179.052112331125;2271.6478945763433;78605.60697196478;81775.9999999994;97317.5134124332;101714.4914275424;102272;17325.913370433067;18301.542461438305;18346.266149353876;18715.625687486445;18905.62188756217;33676.66323336784;33811.32377352439;34168.48747268793;34215.82892085524;34233.657663423044;10615.656068338449;10639.942114304578;10792.136629069655;10839.729006774895;10973.396463194442;9294.302927280482;9385.296102792317;9418.34071614994;9419.764505887271;9615.663451779154;9142.954285228532;9247.95376023129;9266.768330791785;9367.203787677987;9559.474228917337;3364.360771453416;3434.0851429370537;3460.183438625903;3520.767731294027;3624.9275014499563;428.79417879418054;431.87259758371357;433.8091239854454;434.20323705999846;911.8495448250965;11447.484863181176;11885.108616853599;11966.401679916144;12124.090693198046;12390.938045309716;466.4006751324599;467.8128748500627;471.92921061840315;473.11055216193336;479.8080767692881;6149.815505534841;6194.690265486708;6272.8118156455375;6525.1517302750335;6550.475961923034;455239;469164;472120;500532;508263;100681;101608;104876.47561762296;104894;105098;433.0883490253035;435.8082443724751;437.348350957078;439.02317343909544;439.33660173138793;17428.47714568565;18502.259909603465;18880.3391881289;19346.4196074118;19549.413517594494;47026.29460558163;47408;48364;48505.27242091442;48536;53656.19515707345;59637.70181149067;62042.379576205465;63552.36447635465;63663;8544.957275213832;8905.643774248958;12329.815052774395;13487.190768553919;13756.380962856896;14007.719845603235;14888.181150036851;15262.618434539225;15516.534503964898;16060.839391605934;13130.868691312964;13465.596032119052;13499.73000539964;13529.72940541164;13671.86328136706;12856.871431285568;13350.532731354357;13468.730625387634;13570.796438053634;13975;13545.72908541804;13631.364236291709;13687.24720140362;13928.442862285396;13948.651283717989;13690.452381904612;13830.585082447542;13839.723205536035;13856.515021974183;13864.792028119788;13098.934505327412;13570.185788852701;13648.317584120952;13662.180269183484;13710.17738935667 11:40:52 INFO - PROCESS | 18109 | |3;mootools.html;1342.7177045921146;1503.3310176971245;1518.908865468072;1641.9589510262242;1752.4479788866513;8658.740237792868;9080.500572468503;9087.591058402371;9324.254059675226;9336.673216437426;9034.503102329369;9239.399439036459;9241.584128714207;9248.260139188866;9261.95369023154;2086.6348389031937;2153.4078128514707;2154.924577639783;2412.6742889709885;2439.256026911791;2387.1286980252257;2473.1467643662995;2475.3192871960173;2487.639292302615;2490.962635560459;2248.5615305015526;2319.014418871981;2370.3126093432884;2380.428697112689;2391.3184742348435;1974.5359840437486;2037.6739721644465;2338.2634470141934;2342.8242881783763;2348.0490401387465;2080.3238947342024;2300.7584203658707;2376.857388556692;2381.97618023821;2384.701912260967;9136.58885350161;9190.080991900822;9203;9204.907950920538;9207.861882071775;5260.132078207092;5355.223492593552;5374.48942350476;5382.569394448435;5399.4600539945695;3354.010566882751;3409.7613167078316;3433.364827506894;3462.6883580477624;3470.704990075821;1058.6506452870535;1059.9311044782141;1090.733734694187;1128.9548418063268;1133.002957397485;13218.801717974335;13243.933780331134;13275.070745047851;13280.402381892838;13289;4814.518548145157;4815.927761083586;4832.540908613676;4917.1149193144865;4978.626603004716;10878.129749620011;10990.395528245863;11006.449677516091;11010.889891101147;11026.173037022256;5535.446455354432;5554.833354999357;5571.582131340166;5573.5819813514145;5576.888462230732;4472.731636101845;4855.635827312895;5006.799728010911;5091.363579552556;5099.898002039939;4083.57122502133;4197.567634648796;4198.097409057067;4228.534861165269;4251.6598672106775;1284.6274580371773;1326.263923522435;1328.554934097069;1330.6217026587594;1333.973320533584;819.496009953874;866.913308669128;908.9181973622406;923.3951761596165;1010.3937637417491;6262.091996660459;6267;6424.13274207976;6445.291017988017;6518.837029074311;947.507296205969;964.4840010594298;980.7106903463496;1026.1380440430075;1029.0841151375282;4242.087951090531;4334.13317336534;4351.6083552479795;4360.498542667634;4363.345498175236;11068.169887258488;11582.189246752814;11589.942050289694;11662.65012049623;11697.824532632018;11037.282576632653;11375.488103035383;11410.030147437395;11520.884791152148;11758.647240582624;8602.096779838026;8702.173293537104;8703.521306328214;8717.520536370434;8749.1250874912;6232.470240029467;6235.844103897258;6258.3428739983465;6338.397852204033;6400.935990640034;10623.734406639896;10794.244402891722;10794.730131746455;10901;10937.671869843918;10976;11100.61147859821;11167.664970050912;11250.549978000789;11274.323540587264;7391.704331826882;7422.703091876265;7450.96274518624;8285.171482851667;8423.115572865006;8579.485230886166;8923;8928.330375222014;8934.151255630704;8977.910220897707;8209.71266005687;8301.169883011651;8307.875381869157;8393.412461127908;8481.363897707573;8023.959880200561;8104.270615644385;8126.471779334324;8157.8776318354085;8272.958635206785;6878.174619045746;7514.849703006019;7585.051868516435;7608.2391760823475;7612.162662107053;5329.200619907045;5350.30446042012;5397.892042159214;5431.6740995540395;5476.123820188751;5145.176771716508;5277.20841873722;5335.2263921730355;5338;5380.139177731544 11:40:52 INFO - PROCESS | 18109 | |4;prototype.html;336.3709862557019;337.6640242958255;343.4230492772142;343.4899174725532;345.4973014264245;5329.280547126137;5359.276497672813;5384.084705600052;5417.647852889564;5424.321959755031;5264.341957255343;5324.893502129955;5330.200469929512;5337.786488540453;5345.957538280028;3830;3955.4660120883673;4075.1849630073957;4105.958940410603;4155.854545090922;4158.14757974616;4159.708820382574;4169.687273454503;4171.874843754692;4191.434156388894;4124.546299907008;4129.380592911058;4141.482314710661;4152.480939882515;4159.480064991876;3947.131631041166;4028.516578010628;4121.793910304487;4139.77231252281;4170.16596680662;3657.2685462907525;3682.3003629310347;3683.521142251517;3699.85200591976;3701.1117331840433;5132.56373208274;5139.7687104080405;5142.331496905378;5142.562882155022;5149.219421512379;4485.833683242347;4732.9763351183365;4749.833755818529;4764.309175169616;4784.775079587974;5477;5517.751701173457;5526.198701188305;5562.221289019541;5565.469495888622;3988.202359528077;3996.980015099935;4038.939415908734;4040.7575545467366;4044.613677930006;5496.697681627509;5710.086386178233;5720.456556627114;5782.335031471351;5790.392008839095;4039.111395492987;4060.715749897479;4071.002604361891;4076.286649836267;4097.242010228058;4131.938020929689;4136.8138433770555;4145.901336145864;4147.668186545069;4155.4182414462;4474.731516108979;4747.83382581608;4766.666333356701;4770.165221086366;4776.880577985508;5542.778288868481;5553.944460555424;5558.360788509292;5574.275344205227;5579.4420557944695;1422.0330175480772;1443.2495102546827;1444.415011920174;1445.4724025730532;1451.7677171652697;852.4288726553224;922.1516205091332;924.200566509964;928.9071092890792;929.1916033051289;4749.453812811571;4763.928541071887;4765.498113490446;4799.400074990626;4820.855374338776;5024.271480635361;5029.189491782955;5052.520010599061;5057.8229761958155;5062.215356619729;4705.400368717934;4708.176069187878;4724.5826252124225;4746.264329029006;5018.573421259234;2972.524396096614;2990.775691823122;3009.217603423082;3010.7440867526507;3026.772992025607;5820;5844.444777746107;5867.589268751231;5881.441263080001;5905.822825315247;5572.498475137257;5619.185218143428;5634.81668849538;5793.62341447813;5851;5893.6463812171405;5912.940870591239;5926.2295901532525;5944.375840536768;5945.821625351333;5720.856978575569;5736.856578585569;5745;5754.367019627922;5758.971205144115;5448.237246785532;5654.264945557051;5665.546756259571;5666.433356664301;5679.801206957902;5825.650460972355;5827.825165245049;5859.296884373732;5876.588638795243;5929;4010.218007488512;4074.694397920227;4093.5087789465456;4104.768569429219;4113.609207125318;5662.716864156693;5667.263255776723;5682.618841789129;5695.316562012585;5710.543156547549;5545.390007099135;5549.916751248654;5557.277553917965;5578.30271216098;5585.916211256753;5382.838514844561;5488.463230295523;5508.338999319947;5589.413111623221;5590.357108932362;5338.225957236256;5372.865678358073;5388.865278368072;5464.672119672832;5480.808171713971;5508;5567.5545956322585;5590.86022849432;5610.663360198401;5611.915821262766;5328.7602057906715;5409.2427060212385;5422.454600438856;5430.619856609999;5455.563554915677 11:40:52 INFO - PROCESS | 18109 | |5;yui.html;804.3685706720225;843.6541018182545;850.6129710981508;853.3045567862192;862.5773371048181;14999.450093484107;15643.765343519843;15674.843251567481;15676.529704108867;15754.448594299201;14987.92506037471;15092.16993065381;15212.315445804938;15225.23873806308;15254.161021143833;665.6538599928034;782.7064850680995;801.9719309824172;818.1246066708594;824.9051359093721;810.2424233341815;815.2214635023538;815.7552734179752;821.5399376349234;821.9342452603807;854.1586537260794;854.598338780772;854.700854700856;854.9102344253857;855.3200205836375;702.8067281497604;836.6026137584629;857.0401150711181;859.7162936231028;862.1809281182839;625.6683957502486;626.708580510065;627.0187157099125;627.1439485102848;627.1658693937053;13901.930490347484;13911.513097041656;13943.511977080854;13944.790828137586;13997.090189137776;14784.630384240372;15084.622884427867;15149;15169.772453413208;15210.391584336614;13222.140560863609;13232;13482.528111516149;13796.862031379658;13928.791068133985;4677.18149323867;4700.9059818803435;4737.099951009297;4760.285957106427;4895.534924182197;75230.62384688096;75706;75887;76125.61937190333;76400.23599764043;11933.28400295985;12267.509299627915;12316.692082697826;12333.876661233453;12461.75076498465;22591.88704056502;22622;22628;22629.321120366087;22662.886685566795;8246.134155913664;8383.790405239917;8470.49177049379;8498.787530311669;8519.957400213083;4752.7623618818925;4761.523847615211;4842.539958703917;4861.927071093936;4908.214685650279;3312.254742682925;3403.387390269775;3404.5233667286598;3409.607895092096;3411.7100046496325;611.6421893192532;618.5793660310942;623.0809555905095;627.8712863862897;631.3276360675866;629.6033498895666;650.479616306962;652.8792173447928;663.6250518457057;713.1869668577825;9430.151286384258;9483.525823708926;9670.613175472903;9831.88614447897;10073;624.2384291164772;682.9282925292872;682.952193346461;695.2734392559787;730.8099894027591;4537.274036154199;4549.863504094882;4638.1883170445035;4709.50112735362;4720.268358404453;66438.33561664418;110415.44792276148;115597;116979.41510292394;121379;105586;106190;106195;106240;107081;85822.57088714516;86288.56855715682;87343;87888.24816066788;91022;9284.860727089233;9304.95347523258;9315.39449935752;9324.300677449353;9350.158485736316;53823.730881346906;54017.45982540282;54385.28954459883;54580.45419545754;55849.16226256528;69530;77580;77744.2225577737;77766;78265.60867195627;11818.349990750592;11900.345480998629;12146.08904332161;12281.570145044881;12806.295653739135;13360.93319533396;13996;14037.789433158307;15930.60173495672;16630.334786608884;14678.41286348534;14744;14818.703625927206;14831.629209269855;14998.550043498712;14211.218382988622;14307.713845723236;14583.197924114276;15332.923335383251;15596.064236145867;14053.578392648236;14223.857761422254;14373.712525749217;14782.186979716218;14863.405463781328;12050.337231452004;12331.506739730668;12544.21971788954;12707.555235566711;12843.935780321039;12588.748225035632;12721.55474558423;12791.488340466278;12824.679383015498;13082.345882705637 11:40:52 INFO - PROCESS | 18109 | __end_tp_report 11:40:52 INFO - PROCESS | 18109 | __start_cc_report 11:40:52 INFO - PROCESS | 18109 | _x_x_mozilla_cycle_collect,864 11:40:52 INFO - PROCESS | 18109 | __end_cc_report 11:40:52 INFO - PROCESS | 18109 | __startTimestamp1467916852922__endTimestamp 11:40:52 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | ------- Summary: start ------- 11:40:52 INFO - PROCESS | 18109 | Number of tests: 6 11:40:52 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | [#0] dojo.html Cycles:165 Average:5320.83 Median:5497.59 stddev:594.04 (10.8%) stddev-sans-first:569.91 11:40:52 INFO - PROCESS | 18109 | Values: 3107.0 3111.9 3136.9 3151.6 3166.7 5272.8 5273.2 5346.3 5350.7 5380.7 5328.8 5376.8 5388.5 5427.7 5451.7 4861.6 4894.9 4915.4 4916.2 5078.9 4968.9 5000.7 5005.9 5030.5 5035.2 4751.1 4823.0 4888.5 4900.4 4957.6 4782.0 4790.6 4791.1 4799.1 4900.3 4812.9 4833.2 4860.0 4866.6 4920.3 5133.9 5334.1 5406.2 5416.7 5418.3 5708.1 5818.9 5822.7 5826.9 5828.3 5787.7 5820.4 5868.0 5874.9 5876.2 5216.3 5267.2 5318.5 5335.6 5410.6 5905.9 5925.5 5928.2 5928.6 5932.1 5377.2 5693.5 5693.5 5696.7 5706.4 5618.8 5662.2 5675.5 5680.1 5681.0 5654.8 5662.5 5667.3 5669.4 5671.7 5539.2 5649.8 5656.8 5675.5 5684.9 4369.4 4382.5 4388.4 4438.2 4441.2 3913.8 3926.5 3935.1 3937.3 3970.7 5227.6 5276.9 5384.2 5451.3 5491.5 5749.7 5771.4 5792.2 5799.9 5850.9 5415.6 5433.1 5449.6 5455.9 5459.5 4832.0 4926.9 4984.9 4987.1 5049.8 5958.3 5965.7 5969.0 5992.6 6009.9 5786.8 5796.4 5796.7 5797.6 5809.1 5721.2 5774.1 5774.9 5810.7 5969.6 5551.2 5552.1 5565.9 5571.9 5577.1 5612.4 5651.2 5654.9 5657.9 5662.9 5497.6 5556.7 5581.4 5599.2 5631.2 5611.4 5612.9 5621.2 5622.3 5624.0 5385.4 5514.6 5548.8 5563.0 5565.9 5505.7 5534.3 5541.1 5572.4 5625.2 5451.3 5468.6 5476.0 5479.3 5482.7 11:40:52 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | [#1] ext.html Cycles:180 Average:62128.25 Median:43749.89 stddev:121421.01 (277.5%) stddev-sans-first:121673.77 11:40:52 INFO - PROCESS | 18109 | Values: 608.1 626.9 632.0 647.0 650.6 43916.0 45798.0 45856.8 45868.5 49469.8 46522.3 46917.8 46931.8 46942.0 46991.3 9061.4 9195.9 9199.7 9210.9 9218.1 9077.3 9100.2 9137.4 9166.4 9168.0 9015.8 9125.0 9137.8 9143.7 9149.5 9063.6 9132.9 9197.7 9198.0 9198.2 9038.8 9088.6 9104.0 9112.7 9117.4 44486.6 44626.8 44834.3 44857.0 44869.0 3317.0 3603.9 3663.2 3704.2 3814.4 33594.5 34107.8 34249.6 34429.8 35172.5 4541.1 4567.1 4586.4 4658.7 4811.7 362570.0 363727.0 363933.0 365667.0 366243.2 54203.5 59004.7 60729.7 61654.7 62489.4 63902.7 63979.4 64144.7 64285.0 64366.0 16268.6 16271.8 16365.1 16386.8 16407.8 12441.7 13368.9 13682.8 13725.5 13760.6 17900.2 18397.4 18425.7 18466.8 18571.4 6037.5 6075.2 6076.2 6095.4 6114.4 937.9 1061.8 1076.6 1116.1 1148.4 32555.8 33088.3 33105.5 33396.7 33411.2 1106.9 1118.1 1147.2 1198.7 1204.1 17372.0 17595.0 17852.0 17878.1 17937.9 566882.0 573577.0 575568.0 577201.0 578353.0 61464.0 61470.7 61488.4 61610.4 61645.0 1212.9 1304.6 1337.9 1371.4 1383.2 32489.2 33798.2 34035.8 34196.0 34343.7 53051.5 53472.2 53633.7 53760.5 53884.0 401520.0 409467.0 409661.0 409839.0 411536.0 28261.3 38745.2 41164.4 42554.4 43755.0 46612.3 46893.0 49826.5 50037.7 50096.2 41528.0 42821.8 43102.1 43132.4 44587.3 42047.8 42458.0 43282.6 43599.8 43763.0 42345.2 42583.4 43387.6 43532.8 43744.8 33829.7 36266.5 36725.0 36844.4 37184.0 28494.4 28707.9 28738.6 28753.0 28840.3 11:40:52 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | [#2] jquery.html Cycles:180 Average:31284.95 Median:18520.51 stddev:79738.20 (430.5%) stddev-sans-first:79928.18 11:40:52 INFO - PROCESS | 18109 | Values: 402.6 402.8 407.6 408.9 422.7 13847.5 18852.3 20548.7 20551.4 22109.4 19192.3 20257.8 20270.7 20494.3 20786.1 5082.9 5222.7 5225.5 5228.6 5231.6 3880.4 5177.7 5218.4 5223.3 5225.7 7314.8 7708.8 7725.0 7728.8 7870.9 7288.1 7559.4 7574.8 7586.5 7588.0 7204.8 7234.9 7301.2 7333.4 7427.9 27672.7 27981.0 28214.2 28302.0 29351.6 2546.7 2607.2 2624.4 3088.1 3160.9 16529.7 16652.5 16879.2 17131.9 17151.4 2076.8 2155.5 2167.7 2179.1 2271.6 78605.6 81776.0 97317.5 101714.5 102272.0 17325.9 18301.5 18346.3 18715.6 18905.6 33676.7 33811.3 34168.5 34215.8 34233.7 10615.7 10639.9 10792.1 10839.7 10973.4 9294.3 9385.3 9418.3 9419.8 9615.7 9143.0 9248.0 9266.8 9367.2 9559.5 3364.4 3434.1 3460.2 3520.8 3624.9 428.8 431.9 433.8 434.2 911.8 11447.5 11885.1 11966.4 12124.1 12390.9 466.4 467.8 471.9 473.1 479.8 6149.8 6194.7 6272.8 6525.2 6550.5 455239.0 469164.0 472120.0 500532.0 508263.0 100681.0 101608.0 104876.5 104894.0 105098.0 433.1 435.8 437.3 439.0 439.3 17428.5 18502.3 18880.3 19346.4 19549.4 47026.3 47408.0 48364.0 48505.3 48536.0 53656.2 59637.7 62042.4 63552.4 63663.0 8545.0 8905.6 12329.8 13487.2 13756.4 14007.7 14888.2 15262.6 15516.5 16060.8 13130.9 13465.6 13499.7 13529.7 13671.9 12856.9 13350.5 13468.7 13570.8 13975.0 13545.7 13631.4 13687.2 13928.4 13948.7 13690.5 13830.6 13839.7 13856.5 13864.8 13098.9 13570.2 13648.3 13662.2 13710.2 11:40:52 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | [#3] mootools.html Cycles:180 Average:6093.17 Median:4824.23 stddev:3545.46 (73.5%) stddev-sans-first:3537.43 11:40:52 INFO - PROCESS | 18109 | Values: 1342.7 1503.3 1518.9 1642.0 1752.4 8658.7 9080.5 9087.6 9324.3 9336.7 9034.5 9239.4 9241.6 9248.3 9262.0 2086.6 2153.4 2154.9 2412.7 2439.3 2387.1 2473.1 2475.3 2487.6 2491.0 2248.6 2319.0 2370.3 2380.4 2391.3 1974.5 2037.7 2338.3 2342.8 2348.0 2080.3 2300.8 2376.9 2382.0 2384.7 9136.6 9190.1 9203.0 9204.9 9207.9 5260.1 5355.2 5374.5 5382.6 5399.5 3354.0 3409.8 3433.4 3462.7 3470.7 1058.7 1059.9 1090.7 1129.0 1133.0 13218.8 13243.9 13275.1 13280.4 13289.0 4814.5 4815.9 4832.5 4917.1 4978.6 10878.1 10990.4 11006.4 11010.9 11026.2 5535.4 5554.8 5571.6 5573.6 5576.9 4472.7 4855.6 5006.8 5091.4 5099.9 4083.6 4197.6 4198.1 4228.5 4251.7 1284.6 1326.3 1328.6 1330.6 1334.0 819.5 866.9 908.9 923.4 1010.4 6262.1 6267.0 6424.1 6445.3 6518.8 947.5 964.5 980.7 1026.1 1029.1 4242.1 4334.1 4351.6 4360.5 4363.3 11068.2 11582.2 11589.9 11662.7 11697.8 11037.3 11375.5 11410.0 11520.9 11758.6 8602.1 8702.2 8703.5 8717.5 8749.1 6232.5 6235.8 6258.3 6338.4 6400.9 10623.7 10794.2 10794.7 10901.0 10937.7 10976.0 11100.6 11167.7 11250.5 11274.3 7391.7 7422.7 7451.0 8285.2 8423.1 8579.5 8923.0 8928.3 8934.2 8977.9 8209.7 8301.2 8307.9 8393.4 8481.4 8024.0 8104.3 8126.5 8157.9 8273.0 6878.2 7514.8 7585.1 7608.2 7612.2 5329.2 5350.3 5397.9 5431.7 5476.1 5145.2 5277.2 5335.2 5338.0 5380.1 11:40:52 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | [#4] prototype.html Cycles:180 Average:4628.68 Median:5294.62 stddev:1354.66 (25.6%) stddev-sans-first:1319.59 11:40:52 INFO - PROCESS | 18109 | Values: 336.4 337.7 343.4 343.5 345.5 5329.3 5359.3 5384.1 5417.6 5424.3 5264.3 5324.9 5330.2 5337.8 5346.0 3830.0 3955.5 4075.2 4106.0 4155.9 4158.1 4159.7 4169.7 4171.9 4191.4 4124.5 4129.4 4141.5 4152.5 4159.5 3947.1 4028.5 4121.8 4139.8 4170.2 3657.3 3682.3 3683.5 3699.9 3701.1 5132.6 5139.8 5142.3 5142.6 5149.2 4485.8 4733.0 4749.8 4764.3 4784.8 5477.0 5517.8 5526.2 5562.2 5565.5 3988.2 3997.0 4038.9 4040.8 4044.6 5496.7 5710.1 5720.5 5782.3 5790.4 4039.1 4060.7 4071.0 4076.3 4097.2 4131.9 4136.8 4145.9 4147.7 4155.4 4474.7 4747.8 4766.7 4770.2 4776.9 5542.8 5553.9 5558.4 5574.3 5579.4 1422.0 1443.2 1444.4 1445.5 1451.8 852.4 922.2 924.2 928.9 929.2 4749.5 4763.9 4765.5 4799.4 4820.9 5024.3 5029.2 5052.5 5057.8 5062.2 4705.4 4708.2 4724.6 4746.3 5018.6 2972.5 2990.8 3009.2 3010.7 3026.8 5820.0 5844.4 5867.6 5881.4 5905.8 5572.5 5619.2 5634.8 5793.6 5851.0 5893.6 5912.9 5926.2 5944.4 5945.8 5720.9 5736.9 5745.0 5754.4 5759.0 5448.2 5654.3 5665.5 5666.4 5679.8 5825.7 5827.8 5859.3 5876.6 5929.0 4010.2 4074.7 4093.5 4104.8 4113.6 5662.7 5667.3 5682.6 5695.3 5710.5 5545.4 5549.9 5557.3 5578.3 5585.9 5382.8 5488.5 5508.3 5589.4 5590.4 5338.2 5372.9 5388.9 5464.7 5480.8 5508.0 5567.6 5590.9 5610.7 5611.9 5328.8 5409.2 5422.5 5430.6 5455.6 11:40:52 INFO - PROCESS | 18109 | 11:40:52 INFO - PROCESS | 18109 | [#5] yui.html Cycles:180 Average:21192.32 Median:4714.88 stddev:30105.29 (638.5%) stddev-sans-first:30150.82 11:40:52 INFO - PROCESS | 18109 | Values: 804.4 843.7 850.6 853.3 862.6 14999.5 15643.8 15674.8 15676.5 15754.4 14987.9 15092.2 15212.3 15225.2 15254.2 665.7 782.7 802.0 818.1 824.9 810.2 815.2 815.8 821.5 821.9 854.2 854.6 854.7 854.9 855.3 702.8 836.6 857.0 859.7 862.2 625.7 626.7 627.0 627.1 627.2 13901.9 13911.5 13943.5 13944.8 13997.1 14784.6 15084.6 15149.0 15169.8 15210.4 13222.1 13232.0 13482.5 13796.9 13928.8 4677.2 4700.9 4737.1 4760.3 4895.5 75230.6 75706.0 75887.0 76125.6 76400.2 11933.3 12267.5 12316.7 12333.9 12461.8 22591.9 22622.0 22628.0 22629.3 22662.9 8246.1 8383.8 8470.5 8498.8 8520.0 4752.8 4761.5 4842.5 4861.9 4908.2 3312.3 3403.4 3404.5 3409.6 3411.7 611.6 618.6 623.1 627.9 631.3 629.6 650.5 652.9 663.6 713.2 9430.2 9483.5 9670.6 9831.9 10073.0 624.2 682.9 683.0 695.3 730.8 4537.3 4549.9 4638.2 4709.5 4720.3 66438.3 110415.4 115597.0 116979.4 121379.0 105586.0 106190.0 106195.0 106240.0 107081.0 85822.6 86288.6 87343.0 87888.2 91022.0 9284.9 9305.0 9315.4 9324.3 9350.2 53823.7 54017.5 54385.3 54580.5 55849.2 69530.0 77580.0 77744.2 77766.0 78265.6 11818.3 11900.3 12146.1 12281.6 12806.3 13360.9 13996.0 14037.8 15930.6 16630.3 14678.4 14744.0 14818.7 14831.6 14998.6 14211.2 14307.7 14583.2 15332.9 15596.1 14053.6 14223.9 14373.7 14782.2 14863.4 12050.3 12331.5 12544.2 12707.6 12843.9 12588.7 12721.6 12791.5 12824.7 13082.3 11:40:52 INFO - PROCESS | 18109 | -------- Summary: end -------- 11:40:52 INFO - PROCESS | 18109 | 11:40:53 INFO - TEST-INFO | 18109: exit 0 11:40:53 INFO - TEST-OK | dromaeo_css | took 1114435ms 11:40:53 INFO - TEST-START | kraken 11:40:53 INFO - operating with platform_type : linux_ 11:40:53 INFO - Initialising browser for kraken test... 11:40:53 INFO - TEST-INFO | started process 18297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNrzzqO/profile http://localhost:36496/getInfo.html) 11:40:58 INFO - PROCESS | 18297 | __metrics Screen width/height:1600/1200 11:40:58 INFO - PROCESS | 18297 | colorDepth:24 11:40:58 INFO - PROCESS | 18297 | Browser inner width/height: 1024/697 11:40:58 INFO - PROCESS | 18297 | __metrics 11:40:59 INFO - PROCESS | 18297 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:40:59 INFO - PROCESS | 18297 | console.error: PushService: 11:40:59 INFO - PROCESS | 18297 | stateChangeProcessEnqueue: Error transitioning state 11:40:59 INFO - PROCESS | 18297 | UnknownError 11:41:00 INFO - TEST-INFO | 18297: exit 0 11:41:00 INFO - Browser initialized. 11:41:00 INFO - Running cycle 1/1 for kraken test... 11:41:00 INFO - TEST-INFO | started process 18376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNrzzqO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:12 INFO - PROCESS | 18376 | RSS: Main: 157192192 11:41:12 INFO - PROCESS | 18376 | 11:41:14 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36496/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:15 INFO - PROCESS | 18376 | RSS: Main: 215486464 11:41:15 INFO - PROCESS | 18376 | 11:41:17 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36496/tests/kraken/driver.html?testName=audio-dft) 11:41:18 INFO - PROCESS | 18376 | RSS: Main: 202604544 11:41:18 INFO - PROCESS | 18376 | 11:41:21 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36496/tests/kraken/driver.html?testName=audio-fft) 11:41:22 INFO - PROCESS | 18376 | RSS: Main: 269971456 11:41:22 INFO - PROCESS | 18376 | 11:41:24 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36496/tests/kraken/driver.html?testName=audio-oscillator) 11:41:24 INFO - PROCESS | 18376 | RSS: Main: 180858880 11:41:24 INFO - PROCESS | 18376 | 11:41:27 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:27 INFO - PROCESS | 18376 | RSS: Main: 185065472 11:41:27 INFO - PROCESS | 18376 | 11:41:30 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36496/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:31 INFO - PROCESS | 18376 | RSS: Main: 219312128 11:41:31 INFO - PROCESS | 18376 | 11:41:34 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36496/tests/kraken/driver.html?testName=imaging-desaturate) 11:41:35 INFO - PROCESS | 18376 | RSS: Main: 220934144 11:41:35 INFO - PROCESS | 18376 | 11:41:37 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36496/tests/kraken/driver.html?testName=json-parse-financial) 11:41:38 INFO - PROCESS | 18376 | RSS: Main: 220987392 11:41:38 INFO - PROCESS | 18376 | 11:41:40 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:41:40 INFO - PROCESS | 18376 | RSS: Main: 208789504 11:41:40 INFO - PROCESS | 18376 | 11:41:42 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36496/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:41:43 INFO - PROCESS | 18376 | RSS: Main: 210956288 11:41:43 INFO - PROCESS | 18376 | 11:41:45 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:41:45 INFO - PROCESS | 18376 | RSS: Main: 209096704 11:41:45 INFO - PROCESS | 18376 | 11:41:48 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:48 INFO - PROCESS | 18376 | RSS: Main: 222015488 11:41:48 INFO - PROCESS | 18376 | 11:41:51 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:52 INFO - PROCESS | 18376 | RSS: Main: 223436800 11:41:52 INFO - PROCESS | 18376 | 11:41:53 INFO - PROCESS | 18376 | Cycle 1(1): loaded http://localhost:36496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36496/tests/kraken/driver.html?testName=ai-astar) 11:41:54 INFO - PROCESS | 18376 | RSS: Main: 265232384 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | __start_tp_report 11:41:54 INFO - PROCESS | 18376 | _x_x_mozilla_page_load 11:41:54 INFO - PROCESS | 18376 | _x_x_mozilla_page_load_details 11:41:54 INFO - PROCESS | 18376 | |i|pagename|runs| 11:41:54 INFO - PROCESS | 18376 | |0;ai-astar;102;114;110;112;115;110;110;110;109;111 11:41:54 INFO - PROCESS | 18376 | |1;audio-beat-detection;145;117;118;177;116;119;152;122;149;121 11:41:54 INFO - PROCESS | 18376 | |2;audio-dft;162;162;161;161;162;161;160;162;162;161 11:41:54 INFO - PROCESS | 18376 | |3;audio-fft;81;73;75;122;75;76;74;74;97;75 11:41:54 INFO - PROCESS | 18376 | |4;audio-oscillator;83;84;114;84;84;85;118;84;84;125 11:41:54 INFO - PROCESS | 18376 | |5;imaging-gaussian-blur;118;116;117;117;118;117;117;117;117;118 11:41:54 INFO - PROCESS | 18376 | |6;imaging-darkroom;145;149;147;146;145;146;147;146;148;146 11:41:54 INFO - PROCESS | 18376 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 11:41:54 INFO - PROCESS | 18376 | |8;json-parse-financial;53;52;53;52;53;52;53;53;55;53 11:41:54 INFO - PROCESS | 18376 | |9;json-stringify-tinderbox;63;62;62;62;61;61;61;62;62;62 11:41:54 INFO - PROCESS | 18376 | |10;stanford-crypto-aes;76;75;77;76;76;76;81;76;75;78 11:41:54 INFO - PROCESS | 18376 | |11;stanford-crypto-ccm;123;120;120;130;119;130;122;119;186;120 11:41:54 INFO - PROCESS | 18376 | |12;stanford-crypto-pbkdf2;161;155;157;157;157;157;156;157;156;159 11:41:54 INFO - PROCESS | 18376 | |13;stanford-crypto-sha256-iterative;67;63;63;62;62;62;61;62;60;63 11:41:54 INFO - PROCESS | 18376 | __end_tp_report 11:41:54 INFO - PROCESS | 18376 | __start_cc_report 11:41:54 INFO - PROCESS | 18376 | _x_x_mozilla_cycle_collect,1648 11:41:54 INFO - PROCESS | 18376 | __end_cc_report 11:41:54 INFO - PROCESS | 18376 | __startTimestamp1467916914043__endTimestamp 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | ------- Summary: start ------- 11:41:54 INFO - PROCESS | 18376 | Number of tests: 14 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:3.50 (3.2%) stddev-sans-first:2.05 11:41:54 INFO - PROCESS | 18376 | Values: 102.0 114.0 110.0 112.0 115.0 110.0 110.0 110.0 109.0 111.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:133.50 stddev:20.88 (15.6%) stddev-sans-first:21.74 11:41:54 INFO - PROCESS | 18376 | Values: 145.0 117.0 118.0 177.0 116.0 119.0 152.0 122.0 149.0 121.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 11:41:54 INFO - PROCESS | 18376 | Values: 162.0 162.0 161.0 161.0 162.0 161.0 160.0 162.0 162.0 161.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:15.70 (20.9%) stddev-sans-first:16.64 11:41:54 INFO - PROCESS | 18376 | Values: 81.0 73.0 75.0 122.0 75.0 76.0 74.0 74.0 97.0 75.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:84.00 stddev:17.12 (20.4%) stddev-sans-first:17.64 11:41:54 INFO - PROCESS | 18376 | Values: 83.0 84.0 114.0 84.0 84.0 85.0 118.0 84.0 84.0 125.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 11:41:54 INFO - PROCESS | 18376 | Values: 118.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.27 (0.9%) stddev-sans-first:1.22 11:41:54 INFO - PROCESS | 18376 | Values: 145.0 149.0 147.0 146.0 145.0 146.0 147.0 146.0 148.0 146.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:41:54 INFO - PROCESS | 18376 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 11:41:54 INFO - PROCESS | 18376 | Values: 53.0 52.0 53.0 52.0 53.0 52.0 53.0 53.0 55.0 53.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 11:41:54 INFO - PROCESS | 18376 | Values: 63.0 62.0 62.0 62.0 61.0 61.0 61.0 62.0 62.0 62.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:1.78 (2.3%) stddev-sans-first:1.87 11:41:54 INFO - PROCESS | 18376 | Values: 76.0 75.0 77.0 76.0 76.0 76.0 81.0 76.0 75.0 78.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:122.50 stddev:20.49 (16.7%) stddev-sans-first:21.62 11:41:54 INFO - PROCESS | 18376 | Values: 123.0 120.0 120.0 130.0 119.0 130.0 122.0 119.0 186.0 120.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.00 stddev:1.69 (1.1%) stddev-sans-first:1.09 11:41:54 INFO - PROCESS | 18376 | Values: 161.0 155.0 157.0 157.0 157.0 157.0 156.0 157.0 156.0 159.0 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - PROCESS | 18376 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.84 (2.9%) stddev-sans-first:1.00 11:41:54 INFO - PROCESS | 18376 | Values: 67.0 63.0 63.0 62.0 62.0 62.0 61.0 62.0 60.0 63.0 11:41:54 INFO - PROCESS | 18376 | -------- Summary: end -------- 11:41:54 INFO - PROCESS | 18376 | 11:41:54 INFO - TEST-INFO | 18376: exit 0 11:41:55 INFO - TEST-OK | kraken | took 61317ms 11:41:55 INFO - SUITE-END | took 1175s 11:41:55 INFO - Completed test suite (00:19:35) 11:41:55 INFO - javascript benchmark 11:41:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.953395699065, 3111.8599663015166, 3136.8745250189995, 3151.6060492438446, 3166.73082787963, 5272.762725677344, 5273.182656688219, 5346.331708536433, 5350.732463376835, 5380.650257733249, 5328.760205790739, 5376.838694839152, 5388.461153884609, 5427.728613569326, 5451.727413629323, 4861.635377346704, 4894.853154405374, 4915.434725006634, 4916.164252077156, 5078.898422031557, 4968.850934471971, 5000.749962501878, 5005.924911126318, 5030.522100400474, 5035.169197082477, 4751.14479393709, 4822.95177048232, 4888.462269150391, 4900.387451568554, 4957.5786058185095, 4782.0, 4790.616750659939, 4791.089692958361, 4799.064182484417, 4900.338454308659, 4812.855614331575, 4833.2266837306215, 4860.0, 4866.562009419134, 4920.261960705887, 5133.871653208662, 5334.146536554172, 5406.162044883049, 5416.7020813855615, 5418.29562156921, 5708.058170401879, 5818.883622327572, 5822.708864556797, 5826.883462330729, 5828.271466066742, 5787.652740835521, 5820.35976042635, 5868.03177475716, 5874.9412505874825, 5876.236089308405, 5216.347956505437, 5267.157254839208, 5318.5213330800025, 5335.599830012726, 5410.621256512085, 5905.940940590625, 5925.496332811673, 5928.170056192136, 5928.584999050111, 5932.080527518242, 5377.247185394048, 5693.459121383462, 5693.487586117187, 5696.743646535916, 5706.400827913092, 5618.831435056954, 5662.235598194191, 5675.5459563234845, 5680.091185410314, 5680.971595141998, 5654.830355089354, 5662.490375866192, 5667.291588551431, 5669.40471250521, 5671.716414179275, 5539.19681646159, 5649.802256920988, 5656.773729050792, 5675.517581005661, 5684.8863022739315, 4369.43197384338, 4382.517923028464, 4388.385626012361, 4438.1567502174485, 4441.222786012435, 3913.8238779254434, 3926.509186351706, 3935.0555866591812, 3937.2912875682077, 3970.741901776433, 5227.581793456515, 5276.894462110737, 5384.219288203267, 5451.3458384994055, 5491.450854914477, 5749.741261643236, 5771.394003629643, 5792.189093526909, 5799.8550036249435, 5850.853728656818, 5415.620906536584, 5433.130699088127, 5449.64577302474, 5455.863603409946, 5459.454054594509, 4832.0, 4926.901461970812, 4984.925226121611, 4987.077390682735, 5049.798008079709, 5958.255218097738, 5965.701714914324, 5969.04495280753, 5992.610480318765, 6009.879802403927, 5786.797462088806, 5796.391378905154, 5796.710164491674, 5797.594168408171, 5809.070548712186, 5721.170430287668, 5774.105013722879, 5774.9133762994425, 5810.709464526842, 5969.582129250911, 5551.195076713773, 5552.056150454513, 5565.888682226414, 5571.916421253603, 5577.135543990688, 5612.410696876769, 5651.237082993744, 5654.85862853432, 5657.858553536194, 5662.915056274242, 5497.587680924026, 5556.749946252347, 5581.358143813513, 5599.244102046335, 5631.155326701028, 5611.410801865745, 5612.943870561406, 5621.184928185472, 5622.269105016322, 5623.971880140737, 5385.38068122171, 5514.6139770217305, 5548.805791797267, 5562.972185139049, 5565.944340556543, 5505.697186654773, 5534.280543529316, 5541.058020136667, 5572.35917869434, 5625.184348269559, 5451.3458384994055, 5468.589855760754, 5475.972620136874, 5479.287692599936, 5482.671039737628], "value": 5281.617675758015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.0757248981548, 626.8965620672591, 632.0266789144717, 646.9805905822827, 650.6031320894257, 43916.0, 45798.0, 45856.77071614641, 45868.54131458689, 49469.7526512367, 46522.30216546755, 46917.7654111729, 46931.765341173246, 46942.0, 46991.29513057307, 9061.411008284473, 9195.862062069074, 9199.724008279762, 9210.907890921106, 9218.124278193562, 9077.319201059914, 9100.226480749145, 9137.360384773068, 9166.358354915159, 9168.0, 9015.774605634879, 9125.0, 9137.817243655123, 9143.674167245745, 9149.496777677225, 9063.637454501812, 9132.863007054899, 9197.724068277928, 9198.0, 9198.218151457135, 9038.819223615557, 9088.591013404346, 9103.954480227623, 9112.726618201465, 9117.361784675075, 44486.555134448885, 44626.77686611579, 44834.32748508775, 44857.0, 44869.0, 3316.950245746292, 3603.855845766166, 3663.230721548478, 3704.1665625234377, 3814.4087666411474, 33594.496082558784, 34107.82946085279, 34249.56630974468, 34429.827850860835, 35172.47241291357, 4541.137183935041, 4567.109413664337, 4586.4266966629175, 4658.673892827504, 4811.687240329367, 362570.0, 363727.0, 363933.0, 365667.0, 366243.168784157, 54203.45796542063, 59004.7049764757, 60729.69635151796, 61654.691726541976, 62489.37510624927, 63902.680486597266, 63979.36020639827, 64144.67927660425, 64285.0, 64366.0, 16268.593285167966, 16271.755923661154, 16365.099919504542, 16386.75419868703, 16407.835921640868, 12441.688957775947, 13368.866311336957, 13682.794758078637, 13725.45098196081, 13760.587182384545, 17900.194491247927, 18397.3560925367, 18425.723614145798, 18466.815331846778, 18571.44285671432, 6037.50967709705, 6075.210222671025, 6076.240469941257, 6095.384723048396, 6114.449699527064, 937.9484128372868, 1061.830107182847, 1076.5855145768935, 1116.1349953785882, 1148.4081372919381, 32555.837220813744, 33088.3382332352, 33105.50341744876, 33396.66603333984, 33411.164720882174, 1106.856108705863, 1118.0552433193939, 1147.162571322939, 1198.6883410313208, 1204.114975493012, 17372.0, 17595.0, 17852.0, 17878.106094695213, 17937.910310448624, 566882.0, 573577.0, 575568.0, 577201.0, 578353.0, 61464.0, 61470.69264653648, 61488.38511614916, 61610.38389616136, 61645.0, 1212.902967762577, 1304.5564508067303, 1337.9063465557317, 1371.4445649511963, 1383.1839214863078, 32489.187770305933, 33798.15504612404, 34035.82982085074, 34196.0, 34343.65656343505, 53051.46948530465, 53472.1979170305, 53633.73183134059, 53760.46239537711, 53884.0, 401520.0, 409467.0, 409661.0, 409839.0, 411536.0, 28261.293467663472, 38745.2250954985, 41164.38253426261, 42554.36168457538, 43755.0, 46612.300815488474, 46893.0, 49826.50173498219, 50037.749811252164, 50096.157658908945, 41528.0, 42821.78589107034, 43102.137957240055, 43132.353014704175, 44587.331190032826, 42047.789761051, 42458.0, 43282.56717432785, 43599.78200108979, 43763.0, 42345.153096938506, 42583.3612495819, 43387.56612433835, 43532.782336088116, 43744.78127609469, 33829.66170338265, 36266.456003159445, 36725.0, 36844.447333289485, 37184.0, 28494.43011139807, 28707.85646071756, 28738.568921466613, 28753.0, 28840.278993025342], "value": 20837.24018569086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.6094688152491, 402.840877853248, 407.58019240182614, 408.8814243869276, 422.7083312514365, 13847.515336963208, 18852.34016809412, 20548.69176962345, 20551.38345849623, 22109.447263818412, 19192.328268510606, 20257.797422025775, 20270.69593956092, 20494.282700105497, 20786.06462709178, 5082.923756143661, 5222.660527065728, 5225.503577160182, 5228.633995620308, 5231.581473482112, 3880.3791393377064, 5177.715225662587, 5218.373795144569, 5223.320968274119, 5225.712585807779, 7314.81712957175, 7708.807279817994, 7725.034370703662, 7728.768136955872, 7870.921290787105, 7288.08898887639, 7559.3574546163645, 7574.810629734246, 7586.506877052974, 7587.999999999973, 7204.819879503002, 7234.927650723478, 7301.2333704961275, 7333.413326933885, 7427.92295117205, 27672.723272767216, 27981.0, 28214.15357539277, 28302.0, 29351.55972660412, 2546.732593077719, 2607.2308668942705, 2624.448865738197, 3088.119885832527, 3160.873565057395, 16529.6694066118, 16652.50042498727, 16879.24043418049, 17131.914340428342, 17151.399701010403, 2076.7611724651556, 2155.504234026183, 2167.6856855755827, 2179.052112331125, 2271.6478945763433, 78605.60697196478, 81775.9999999994, 97317.5134124332, 101714.4914275424, 102272.0, 17325.913370433067, 18301.542461438305, 18346.266149353876, 18715.625687486445, 18905.62188756217, 33676.66323336784, 33811.32377352439, 34168.48747268793, 34215.82892085524, 34233.657663423044, 10615.656068338449, 10639.942114304578, 10792.136629069655, 10839.729006774895, 10973.396463194442, 9294.302927280482, 9385.296102792317, 9418.34071614994, 9419.764505887271, 9615.663451779154, 9142.954285228532, 9247.95376023129, 9266.768330791785, 9367.203787677987, 9559.474228917337, 3364.360771453416, 3434.0851429370537, 3460.183438625903, 3520.767731294027, 3624.9275014499563, 428.79417879418054, 431.87259758371357, 433.8091239854454, 434.20323705999846, 911.8495448250965, 11447.484863181176, 11885.108616853599, 11966.401679916144, 12124.090693198046, 12390.938045309716, 466.4006751324599, 467.8128748500627, 471.92921061840315, 473.11055216193336, 479.8080767692881, 6149.815505534841, 6194.690265486708, 6272.8118156455375, 6525.1517302750335, 6550.475961923034, 455239.0, 469164.0, 472120.0, 500532.0, 508263.0, 100681.0, 101608.0, 104876.47561762296, 104894.0, 105098.0, 433.0883490253035, 435.8082443724751, 437.348350957078, 439.02317343909544, 439.33660173138793, 17428.47714568565, 18502.259909603465, 18880.3391881289, 19346.4196074118, 19549.413517594494, 47026.29460558163, 47408.0, 48364.0, 48505.27242091442, 48536.0, 53656.19515707345, 59637.70181149067, 62042.379576205465, 63552.36447635465, 63663.0, 8544.957275213832, 8905.643774248958, 12329.815052774395, 13487.190768553919, 13756.380962856896, 14007.719845603235, 14888.181150036851, 15262.618434539225, 15516.534503964898, 16060.839391605934, 13130.868691312964, 13465.596032119052, 13499.73000539964, 13529.72940541164, 13671.86328136706, 12856.871431285568, 13350.532731354357, 13468.730625387634, 13570.796438053634, 13975.0, 13545.72908541804, 13631.364236291709, 13687.24720140362, 13928.442862285396, 13948.651283717989, 13690.452381904612, 13830.585082447542, 13839.723205536035, 13856.515021974183, 13864.792028119788, 13098.934505327412, 13570.185788852701, 13648.317584120952, 13662.180269183484, 13710.17738935667], "value": 10150.384039293845, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.7177045921146, 1503.3310176971245, 1518.908865468072, 1641.9589510262242, 1752.4479788866513, 8658.740237792868, 9080.500572468503, 9087.591058402371, 9324.254059675226, 9336.673216437426, 9034.503102329369, 9239.399439036459, 9241.584128714207, 9248.260139188866, 9261.95369023154, 2086.6348389031937, 2153.4078128514707, 2154.924577639783, 2412.6742889709885, 2439.256026911791, 2387.1286980252257, 2473.1467643662995, 2475.3192871960173, 2487.639292302615, 2490.962635560459, 2248.5615305015526, 2319.014418871981, 2370.3126093432884, 2380.428697112689, 2391.3184742348435, 1974.5359840437486, 2037.6739721644465, 2338.2634470141934, 2342.8242881783763, 2348.0490401387465, 2080.3238947342024, 2300.7584203658707, 2376.857388556692, 2381.97618023821, 2384.701912260967, 9136.58885350161, 9190.080991900822, 9203.0, 9204.907950920538, 9207.861882071775, 5260.132078207092, 5355.223492593552, 5374.48942350476, 5382.569394448435, 5399.4600539945695, 3354.010566882751, 3409.7613167078316, 3433.364827506894, 3462.6883580477624, 3470.704990075821, 1058.6506452870535, 1059.9311044782141, 1090.733734694187, 1128.9548418063268, 1133.002957397485, 13218.801717974335, 13243.933780331134, 13275.070745047851, 13280.402381892838, 13289.0, 4814.518548145157, 4815.927761083586, 4832.540908613676, 4917.1149193144865, 4978.626603004716, 10878.129749620011, 10990.395528245863, 11006.449677516091, 11010.889891101147, 11026.173037022256, 5535.446455354432, 5554.833354999357, 5571.582131340166, 5573.5819813514145, 5576.888462230732, 4472.731636101845, 4855.635827312895, 5006.799728010911, 5091.363579552556, 5099.898002039939, 4083.57122502133, 4197.567634648796, 4198.097409057067, 4228.534861165269, 4251.6598672106775, 1284.6274580371773, 1326.263923522435, 1328.554934097069, 1330.6217026587594, 1333.973320533584, 819.496009953874, 866.913308669128, 908.9181973622406, 923.3951761596165, 1010.3937637417491, 6262.091996660459, 6267.0, 6424.13274207976, 6445.291017988017, 6518.837029074311, 947.507296205969, 964.4840010594298, 980.7106903463496, 1026.1380440430075, 1029.0841151375282, 4242.087951090531, 4334.13317336534, 4351.6083552479795, 4360.498542667634, 4363.345498175236, 11068.169887258488, 11582.189246752814, 11589.942050289694, 11662.65012049623, 11697.824532632018, 11037.282576632653, 11375.488103035383, 11410.030147437395, 11520.884791152148, 11758.647240582624, 8602.096779838026, 8702.173293537104, 8703.521306328214, 8717.520536370434, 8749.1250874912, 6232.470240029467, 6235.844103897258, 6258.3428739983465, 6338.397852204033, 6400.935990640034, 10623.734406639896, 10794.244402891722, 10794.730131746455, 10901.0, 10937.671869843918, 10976.0, 11100.61147859821, 11167.664970050912, 11250.549978000789, 11274.323540587264, 7391.704331826882, 7422.703091876265, 7450.96274518624, 8285.171482851667, 8423.115572865006, 8579.485230886166, 8923.0, 8928.330375222014, 8934.151255630704, 8977.910220897707, 8209.71266005687, 8301.169883011651, 8307.875381869157, 8393.412461127908, 8481.363897707573, 8023.959880200561, 8104.270615644385, 8126.471779334324, 8157.8776318354085, 8272.958635206785, 6878.174619045746, 7514.849703006019, 7585.051868516435, 7608.2391760823475, 7612.162662107053, 5329.200619907045, 5350.30446042012, 5397.892042159214, 5431.6740995540395, 5476.123820188751, 5145.176771716508, 5277.20841873722, 5335.2263921730355, 5338.0, 5380.139177731544], "value": 4811.566009829019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.3709862557019, 337.6640242958255, 343.4230492772142, 343.4899174725532, 345.4973014264245, 5329.280547126137, 5359.276497672813, 5384.084705600052, 5417.647852889564, 5424.321959755031, 5264.341957255343, 5324.893502129955, 5330.200469929512, 5337.786488540453, 5345.957538280028, 3830.0, 3955.4660120883673, 4075.1849630073957, 4105.958940410603, 4155.854545090922, 4158.14757974616, 4159.708820382574, 4169.687273454503, 4171.874843754692, 4191.434156388894, 4124.546299907008, 4129.380592911058, 4141.482314710661, 4152.480939882515, 4159.480064991876, 3947.131631041166, 4028.516578010628, 4121.793910304487, 4139.77231252281, 4170.16596680662, 3657.2685462907525, 3682.3003629310347, 3683.521142251517, 3699.85200591976, 3701.1117331840433, 5132.56373208274, 5139.7687104080405, 5142.331496905378, 5142.562882155022, 5149.219421512379, 4485.833683242347, 4732.9763351183365, 4749.833755818529, 4764.309175169616, 4784.775079587974, 5477.0, 5517.751701173457, 5526.198701188305, 5562.221289019541, 5565.469495888622, 3988.202359528077, 3996.980015099935, 4038.939415908734, 4040.7575545467366, 4044.613677930006, 5496.697681627509, 5710.086386178233, 5720.456556627114, 5782.335031471351, 5790.392008839095, 4039.111395492987, 4060.715749897479, 4071.002604361891, 4076.286649836267, 4097.242010228058, 4131.938020929689, 4136.8138433770555, 4145.901336145864, 4147.668186545069, 4155.4182414462, 4474.731516108979, 4747.83382581608, 4766.666333356701, 4770.165221086366, 4776.880577985508, 5542.778288868481, 5553.944460555424, 5558.360788509292, 5574.275344205227, 5579.4420557944695, 1422.0330175480772, 1443.2495102546827, 1444.415011920174, 1445.4724025730532, 1451.7677171652697, 852.4288726553224, 922.1516205091332, 924.200566509964, 928.9071092890792, 929.1916033051289, 4749.453812811571, 4763.928541071887, 4765.498113490446, 4799.400074990626, 4820.855374338776, 5024.271480635361, 5029.189491782955, 5052.520010599061, 5057.8229761958155, 5062.215356619729, 4705.400368717934, 4708.176069187878, 4724.5826252124225, 4746.264329029006, 5018.573421259234, 2972.524396096614, 2990.775691823122, 3009.217603423082, 3010.7440867526507, 3026.772992025607, 5820.0, 5844.444777746107, 5867.589268751231, 5881.441263080001, 5905.822825315247, 5572.498475137257, 5619.185218143428, 5634.81668849538, 5793.62341447813, 5851.0, 5893.6463812171405, 5912.940870591239, 5926.2295901532525, 5944.375840536768, 5945.821625351333, 5720.856978575569, 5736.856578585569, 5745.0, 5754.367019627922, 5758.971205144115, 5448.237246785532, 5654.264945557051, 5665.546756259571, 5666.433356664301, 5679.801206957902, 5825.650460972355, 5827.825165245049, 5859.296884373732, 5876.588638795243, 5929.0, 4010.218007488512, 4074.694397920227, 4093.5087789465456, 4104.768569429219, 4113.609207125318, 5662.716864156693, 5667.263255776723, 5682.618841789129, 5695.316562012585, 5710.543156547549, 5545.390007099135, 5549.916751248654, 5557.277553917965, 5578.30271216098, 5585.916211256753, 5382.838514844561, 5488.463230295523, 5508.338999319947, 5589.413111623221, 5590.357108932362, 5338.225957236256, 5372.865678358073, 5388.865278368072, 5464.672119672832, 5480.808171713971, 5508.0, 5567.5545956322585, 5590.86022849432, 5610.663360198401, 5611.915821262766, 5328.7602057906715, 5409.2427060212385, 5422.454600438856, 5430.619856609999, 5455.563554915677], "value": 4200.220005306802, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.3685706720225, 843.6541018182545, 850.6129710981508, 853.3045567862192, 862.5773371048181, 14999.450093484107, 15643.765343519843, 15674.843251567481, 15676.529704108867, 15754.448594299201, 14987.92506037471, 15092.16993065381, 15212.315445804938, 15225.23873806308, 15254.161021143833, 665.6538599928034, 782.7064850680995, 801.9719309824172, 818.1246066708594, 824.9051359093721, 810.2424233341815, 815.2214635023538, 815.7552734179752, 821.5399376349234, 821.9342452603807, 854.1586537260794, 854.598338780772, 854.700854700856, 854.9102344253857, 855.3200205836375, 702.8067281497604, 836.6026137584629, 857.0401150711181, 859.7162936231028, 862.1809281182839, 625.6683957502486, 626.708580510065, 627.0187157099125, 627.1439485102848, 627.1658693937053, 13901.930490347484, 13911.513097041656, 13943.511977080854, 13944.790828137586, 13997.090189137776, 14784.630384240372, 15084.622884427867, 15149.0, 15169.772453413208, 15210.391584336614, 13222.140560863609, 13232.0, 13482.528111516149, 13796.862031379658, 13928.791068133985, 4677.18149323867, 4700.9059818803435, 4737.099951009297, 4760.285957106427, 4895.534924182197, 75230.62384688096, 75706.0, 75887.0, 76125.61937190333, 76400.23599764043, 11933.28400295985, 12267.509299627915, 12316.692082697826, 12333.876661233453, 12461.75076498465, 22591.88704056502, 22622.0, 22628.0, 22629.321120366087, 22662.886685566795, 8246.134155913664, 8383.790405239917, 8470.49177049379, 8498.787530311669, 8519.957400213083, 4752.7623618818925, 4761.523847615211, 4842.539958703917, 4861.927071093936, 4908.214685650279, 3312.254742682925, 3403.387390269775, 3404.5233667286598, 3409.607895092096, 3411.7100046496325, 611.6421893192532, 618.5793660310942, 623.0809555905095, 627.8712863862897, 631.3276360675866, 629.6033498895666, 650.479616306962, 652.8792173447928, 663.6250518457057, 713.1869668577825, 9430.151286384258, 9483.525823708926, 9670.613175472903, 9831.88614447897, 10073.0, 624.2384291164772, 682.9282925292872, 682.952193346461, 695.2734392559787, 730.8099894027591, 4537.274036154199, 4549.863504094882, 4638.1883170445035, 4709.50112735362, 4720.268358404453, 66438.33561664418, 110415.44792276148, 115597.0, 116979.41510292394, 121379.0, 105586.0, 106190.0, 106195.0, 106240.0, 107081.0, 85822.57088714516, 86288.56855715682, 87343.0, 87888.24816066788, 91022.0, 9284.860727089233, 9304.95347523258, 9315.39449935752, 9324.300677449353, 9350.158485736316, 53823.730881346906, 54017.45982540282, 54385.28954459883, 54580.45419545754, 55849.16226256528, 69530.0, 77580.0, 77744.2225577737, 77766.0, 78265.60867195627, 11818.349990750592, 11900.345480998629, 12146.08904332161, 12281.570145044881, 12806.295653739135, 13360.93319533396, 13996.0, 14037.789433158307, 15930.60173495672, 16630.334786608884, 14678.41286348534, 14744.0, 14818.703625927206, 14831.629209269855, 14998.550043498712, 14211.218382988622, 14307.713845723236, 14583.197924114276, 15332.923335383251, 15596.064236145867, 14053.578392648236, 14223.857761422254, 14373.712525749217, 14782.186979716218, 14863.405463781328, 12050.337231452004, 12331.506739730668, 12544.21971788954, 12707.555235566711, 12843.935780321039, 12588.748225035632, 12721.55474558423, 12791.488340466278, 12824.679383015498, 13082.345882705637], "value": 7737.721117605338, "unit": "score"}], "name": "dromaeo_css", "value": 7476.839388658633, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 110.0, 112.0, 115.0, 110.0, 110.0, 110.0, 109.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 118.0, 177.0, 116.0, 119.0, 152.0, 122.0, 149.0, 121.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0, 162.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 75.0, 122.0, 75.0, 76.0, 74.0, 74.0, 97.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 114.0, 84.0, 84.0, 85.0, 118.0, 84.0, 84.0, 125.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 149.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 148.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 53.0, 52.0, 53.0, 53.0, 55.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 76.0, 76.0, 76.0, 81.0, 76.0, 75.0, 78.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 120.0, 130.0, 119.0, 130.0, 122.0, 119.0, 186.0, 120.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 155.0, 157.0, 157.0, 157.0, 157.0, 156.0, 157.0, 156.0, 159.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0, 60.0, 63.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1480.5, "alertThreshold": 2.0}]} 11:41:55 INFO - Return code: 0 11:41:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:55 INFO - # TBPL SUCCESS # 11:41:55 INFO - Running post-action listener: _resource_record_post_action 11:41:55 INFO - ##### 11:41:55 INFO - ##### Finished run-tests step (success) 11:41:55 INFO - ##### 11:41:55 INFO - Running post-run listener: _resource_record_post_run 11:41:55 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556703744; Read time: 8; Write time: 1549736 11:41:55 INFO - TinderboxPrint: CPU usage
13.1% 11:41:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:41:55 INFO - TinderboxPrint: I/O write bytes / time
556,703,744 / 1,549,736 11:41:55 INFO - TinderboxPrint: CPU idle
8,275.9 (86.9%) 11:41:55 INFO - TinderboxPrint: CPU user
1,190.8 (12.5%) 11:41:55 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:55 INFO - install - Wall time: 18s; CPU: 19.0%; Read bytes: 0; Write bytes: 261042176; Read time: 0; Write time: 1047812 11:41:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 295661568; Read time: 0; Write time: 501924 11:41:55 INFO - Running post-run listener: _upload_blobber_files 11:41:55 INFO - Blob upload gear active. 11:41:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:55 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 11:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:56 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:59 INFO - (blobuploader) - INFO - Done attempting. 11:41:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:41:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:00 INFO - (blobuploader) - INFO - Done attempting. 11:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:01 INFO - (blobuploader) - INFO - Done attempting. 11:42:01 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:01 INFO - Return code: 0 11:42:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6586990e4fc437f738f7116982b3661e51e52bcf7bcfdfe1d67264370a9e743d117150149255ac64f372db5006806594b09cc8d3a192cdfbc17f841bda7af79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/132e8f214e99389d90b5cc46426d67553eed600aa58a25a0c469165f7b2fe7bcec11dbe1ef0c21fdeeaad83c8c07baa75aa99ee1b1f345579a15bb133ed81d7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91bed20d42ab48e1d6567b3da4d25ba82bf340f574d91ea2217066b13bdc666eb6c0b29d430fc74035dbca88afefacbee714c1566aa00bed3d513b1d8cd6800c"} 11:42:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:01 INFO - Contents: 11:42:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6586990e4fc437f738f7116982b3661e51e52bcf7bcfdfe1d67264370a9e743d117150149255ac64f372db5006806594b09cc8d3a192cdfbc17f841bda7af79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/132e8f214e99389d90b5cc46426d67553eed600aa58a25a0c469165f7b2fe7bcec11dbe1ef0c21fdeeaad83c8c07baa75aa99ee1b1f345579a15bb133ed81d7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91bed20d42ab48e1d6567b3da4d25ba82bf340f574d91ea2217066b13bdc666eb6c0b29d430fc74035dbca88afefacbee714c1566aa00bed3d513b1d8cd6800c"} 11:42:01 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:01 INFO - Copying logs to upload dir... 11:42:01 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.686263 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-07 11:42:01.410288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 11:42:01.413945) ========= 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=df17445c3590ff7897617a0e00000225-1467915683.891085-481255111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6586990e4fc437f738f7116982b3661e51e52bcf7bcfdfe1d67264370a9e743d117150149255ac64f372db5006806594b09cc8d3a192cdfbc17f841bda7af79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/132e8f214e99389d90b5cc46426d67553eed600aa58a25a0c469165f7b2fe7bcec11dbe1ef0c21fdeeaad83c8c07baa75aa99ee1b1f345579a15bb133ed81d7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91bed20d42ab48e1d6567b3da4d25ba82bf340f574d91ea2217066b13bdc666eb6c0b29d430fc74035dbca88afefacbee714c1566aa00bed3d513b1d8cd6800c"} build_url:https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/BjtehvBsQgeSpne-bfpVhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6586990e4fc437f738f7116982b3661e51e52bcf7bcfdfe1d67264370a9e743d117150149255ac64f372db5006806594b09cc8d3a192cdfbc17f841bda7af79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/132e8f214e99389d90b5cc46426d67553eed600aa58a25a0c469165f7b2fe7bcec11dbe1ef0c21fdeeaad83c8c07baa75aa99ee1b1f345579a15bb133ed81d7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91bed20d42ab48e1d6567b3da4d25ba82bf340f574d91ea2217066b13bdc666eb6c0b29d430fc74035dbca88afefacbee714c1566aa00bed3d513b1d8cd6800c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 11:42:01.442750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:42:01.443099) ========= 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=df17445c3590ff7897617a0e00000225-1467915683.891085-481255111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:42:01.530914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 11:42:01.531820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 11:42:01.532241) ========= ========= Total master_lag: 0.18 =========